builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1460755875.96 results: success (0) buildid: 20160415134642 builduid: 7907857672884246901353948a758700 revision: 6a623b9d45990722da19fc864c7ef820821bd4b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.955493) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.955925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.956224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.970621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:15.970908) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 14:31: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-04-15 14:31:17 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075198 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.059582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.059955) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.109908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.110280) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a623b9d45990722da19fc864c7ef820821bd4b0 --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 6a623b9d45990722da19fc864c7ef820821bd4b0 --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=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 14:31:17,524 truncating revision to first 12 chars 2016-04-15 14:31:17,524 Setting DEBUG logging. 2016-04-15 14:31:17,524 attempt 1/10 2016-04-15 14:31:17,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a623b9d4599?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 14:31:17,767 unpacking tar archive at: fx-team-6a623b9d4599/testing/mozharness/ program finished with exit code 0 elapsedTime=0.513831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.637142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.637452) ========= script_repo_revision: 6a623b9d45990722da19fc864c7ef820821bd4b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.637869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.638155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 14:31:16.739082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-15 14:31:16.739481) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:18 INFO - MultiFileLogger online at 20160415 14:31:18 in /builds/slave/test 14:31:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:31:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:18 INFO - {'append_to_log': False, 14:31:18 INFO - 'base_work_dir': '/builds/slave/test', 14:31:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:31:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:18 INFO - 'branch': 'Fx-Team-Non-PGO', 14:31:18 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:18 INFO - 'config_files': ('talos/linux_config.py',), 14:31:18 INFO - 'default_actions': ('clobber', 14:31:18 INFO - 'read-buildbot-config', 14:31:18 INFO - 'download-and-extract', 14:31:18 INFO - 'populate-webroot', 14:31:18 INFO - 'create-virtualenv', 14:31:18 INFO - 'install', 14:31:18 INFO - 'run-tests'), 14:31:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:18 INFO - 'download_minidump_stackwalk': True, 14:31:18 INFO - 'download_symbols': 'ondemand', 14:31:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:18 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:18 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:18 INFO - 'installer_path': 'installer.exe', 14:31:18 INFO - 'log_level': 'info', 14:31:18 INFO - 'log_name': 'talos', 14:31:18 INFO - 'log_to_console': True, 14:31:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:18 INFO - 'opt_config_files': (), 14:31:18 INFO - 'pip_index': False, 14:31:18 INFO - 'sps_profile': False, 14:31:18 INFO - 'sps_profile_interval': 0, 14:31:18 INFO - 'suite': 'dromaeojs-e10s', 14:31:18 INFO - 'system_bits': '32', 14:31:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:18 INFO - 'title': 'talos-linux64-ix-005', 14:31:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:18 INFO - 'use_talos_json': True, 14:31:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:18 INFO - 'work_dir': 'build'} 14:31:18 INFO - ##### 14:31:18 INFO - ##### Running clobber step. 14:31:18 INFO - ##### 14:31:18 INFO - Running pre-action listener: _resource_record_pre_action 14:31:18 INFO - Running main action method: clobber 14:31:18 INFO - rmtree: /builds/slave/test/build 14:31:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:19 INFO - Running post-action listener: _resource_record_post_action 14:31:19 INFO - ##### 14:31:19 INFO - ##### Running read-buildbot-config step. 14:31:19 INFO - ##### 14:31:19 INFO - Running pre-action listener: _resource_record_pre_action 14:31:19 INFO - Running main action method: read_buildbot_config 14:31:19 INFO - Using buildbot properties: 14:31:19 INFO - { 14:31:19 INFO - "project": "", 14:31:19 INFO - "product": "firefox", 14:31:19 INFO - "script_repo_revision": "production", 14:31:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:31:19 INFO - "repository": "", 14:31:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:31:19 INFO - "buildid": "20160415134642", 14:31:19 INFO - "pgo_build": "False", 14:31:19 INFO - "basedir": "/builds/slave/test", 14:31:19 INFO - "buildnumber": 1153, 14:31:19 INFO - "slavename": "talos-linux64-ix-005", 14:31:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:31:19 INFO - "platform": "ubuntu64_hw", 14:31:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:31:19 INFO - "branch": "fx-team", 14:31:19 INFO - "repo_path": "integration/fx-team", 14:31:19 INFO - "revision": "6a623b9d45990722da19fc864c7ef820821bd4b0", 14:31:19 INFO - "stage_platform": "linux64", 14:31:19 INFO - "builduid": "7907857672884246901353948a758700", 14:31:19 INFO - "slavebuilddir": "test" 14:31:19 INFO - } 14:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:31:19 INFO - Running post-action listener: _resource_record_post_action 14:31:19 INFO - ##### 14:31:19 INFO - ##### Running download-and-extract step. 14:31:19 INFO - ##### 14:31:19 INFO - Running pre-action listener: _resource_record_pre_action 14:31:19 INFO - Running main action method: download_and_extract 14:31:19 INFO - mkdir: /builds/slave/test/build/tests 14:31: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')]} 14:31:19 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:31:23 INFO - Downloaded 1361 bytes. 14:31:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:31:23 INFO - Using the following test package requirements: 14:31:23 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:31:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'jsshell-linux-x86_64.zip'], 14:31:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:31:23 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:31:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:23 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31: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')]} 14:31:23 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:25 INFO - Downloaded 22205647 bytes. 14:31:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:26 INFO - Return code: 0 14:31:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:31:26 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')]} 14:31:26 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:31:28 INFO - Downloaded 22205647 bytes. 14:31:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:31:29 INFO - Return code: 0 14:31:29 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')]} 14:31:29 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:31:30 INFO - Downloaded 10841076 bytes. 14:31:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:31:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:31:31 INFO - Return code: 0 14:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:31 INFO - https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:31:32 INFO - Downloaded 54453664 bytes. 14:31:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:32 INFO - mkdir: /builds/slave/test/properties 14:31:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:32 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:32 INFO - Contents: 14:31:32 INFO - build_url:https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:31:33 INFO - Running post-action listener: _resource_record_post_action 14:31:33 INFO - Running post-action listener: set_extra_try_arguments 14:31:33 INFO - ##### 14:31:33 INFO - ##### Running populate-webroot step. 14:31:33 INFO - ##### 14:31:33 INFO - Running pre-action listener: _resource_record_pre_action 14:31:33 INFO - Running main action method: populate_webroot 14:31:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:33 INFO - '--tppagecycles', 14:31:33 INFO - '7'], 14:31:33 INFO - 'tests': ['tsvgm']}}, 14:31:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:31:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:31:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['damp', 'tps']}, 14:31:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'tests': ['damp', 'tps']}, 14:31:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['dromaeo_dom']}, 14:31:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'other-e10s': {'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['a11yr', 14:31:33 INFO - 'ts_paint', 14:31:33 INFO - 'tpaint', 14:31:33 INFO - 'sessionrestore', 14:31:33 INFO - 'sessionrestore_no_auto_restore', 14:31:33 INFO - 'tabpaint']}, 14:31:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['tsvgx', 14:31:33 INFO - 'tsvgr_opacity', 14:31:33 INFO - 'tart', 14:31:33 INFO - 'tscrollx', 14:31:33 INFO - 'cart']}, 14:31:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:31:33 INFO - 'tsvgr_opacity', 14:31:33 INFO - 'tart', 14:31:33 INFO - 'tscrollx', 14:31:33 INFO - 'cart']}, 14:31:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'talos_options': ['--disable-e10s'], 14:31:33 INFO - 'tests': ['tp5o']}, 14:31:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'tests': ['tp5o']}, 14:31:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'talos_options': ['--disable-e10s', 14:31:33 INFO - '--xperf_path', 14:31:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:33 INFO - 'tests': ['tp5n']}, 14:31:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:33 INFO - 'talos_options': ['--xperf_path', 14:31:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:33 INFO - 'tests': ['tp5n']}}, 14:31:33 INFO - 'talos.zip': {'path': '', 14:31:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:33 INFO - Running post-action listener: _resource_record_post_action 14:31:33 INFO - ##### 14:31:33 INFO - ##### Running create-virtualenv step. 14:31:33 INFO - ##### 14:31:33 INFO - Running pre-action listener: _resource_record_pre_action 14:31:33 INFO - Running main action method: create_virtualenv 14:31:33 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:33 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 14:31:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:33 INFO - Using real prefix '/usr' 14:31:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:35 INFO - Installing pip.................done. 14:31:35 INFO - Return code: 0 14:31:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:36 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 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:36 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 14:31:36 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 14:31:36 INFO - Using env: {'DISPLAY': ':0', 14:31:36 INFO - 'HOME': '/home/cltbld', 14:31:36 INFO - 'LANG': 'en_US.UTF-8', 14:31:36 INFO - 'LANGUAGE': 'en_US:en', 14:31:36 INFO - 'LOGNAME': 'cltbld', 14:31:36 INFO - 'MAIL': '/var/mail/cltbld', 14:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:36 INFO - 'MOZ_NO_REMOTE': '1', 14:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:36 INFO - 'NO_EM_RESTART': '1', 14:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:36 INFO - 'PWD': '/builds/slave/test', 14:31:36 INFO - 'SHELL': '/bin/bash', 14:31:36 INFO - 'SHLVL': '1', 14:31:36 INFO - 'TERM': 'linux', 14:31:36 INFO - 'TMOUT': '86400', 14:31:36 INFO - 'USER': 'cltbld', 14:31:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:36 INFO - '_': '/tools/buildbot/bin/python'} 14:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:36 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 14:31:36 INFO - Cleaning up... 14:31:36 INFO - Return code: 0 14:31:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:36 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:36 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>=0.7.1'] in /builds/slave/test/build 14:31:36 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>=0.7.1 14:31:36 INFO - Using env: {'DISPLAY': ':0', 14:31:36 INFO - 'HOME': '/home/cltbld', 14:31:36 INFO - 'LANG': 'en_US.UTF-8', 14:31:36 INFO - 'LANGUAGE': 'en_US:en', 14:31:36 INFO - 'LOGNAME': 'cltbld', 14:31:36 INFO - 'MAIL': '/var/mail/cltbld', 14:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:36 INFO - 'MOZ_NO_REMOTE': '1', 14:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:36 INFO - 'NO_EM_RESTART': '1', 14:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:36 INFO - 'PWD': '/builds/slave/test', 14:31:36 INFO - 'SHELL': '/bin/bash', 14:31:36 INFO - 'SHLVL': '1', 14:31:36 INFO - 'TERM': 'linux', 14:31:36 INFO - 'TMOUT': '86400', 14:31:36 INFO - 'USER': 'cltbld', 14:31:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:36 INFO - '_': '/tools/buildbot/bin/python'} 14:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:36 INFO - Downloading/unpacking psutil>=0.7.1 14:31:36 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 14:31:36 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 14:31:36 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 14:31:36 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 14:31:36 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 14:31:36 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 14:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:38 INFO - Installing collected packages: psutil 14:31:38 INFO - Running setup.py install for psutil 14:31:38 INFO - building 'psutil._psutil_linux' extension 14:31:38 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 14:31:38 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 14:31:38 INFO - building 'psutil._psutil_posix' extension 14:31:38 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 14:31:38 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 14:31:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:38 INFO - Successfully installed psutil 14:31:38 INFO - Cleaning up... 14:31:38 INFO - Return code: 0 14:31:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:38 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:38 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.0.0'] in /builds/slave/test/build 14:31:38 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.0.0 14:31:38 INFO - Using env: {'DISPLAY': ':0', 14:31:38 INFO - 'HOME': '/home/cltbld', 14:31:38 INFO - 'LANG': 'en_US.UTF-8', 14:31:38 INFO - 'LANGUAGE': 'en_US:en', 14:31:38 INFO - 'LOGNAME': 'cltbld', 14:31:38 INFO - 'MAIL': '/var/mail/cltbld', 14:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:38 INFO - 'MOZ_NO_REMOTE': '1', 14:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:38 INFO - 'NO_EM_RESTART': '1', 14:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:38 INFO - 'PWD': '/builds/slave/test', 14:31:38 INFO - 'SHELL': '/bin/bash', 14:31:38 INFO - 'SHLVL': '1', 14:31:38 INFO - 'TERM': 'linux', 14:31:38 INFO - 'TMOUT': '86400', 14:31:38 INFO - 'USER': 'cltbld', 14:31:38 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:38 INFO - '_': '/tools/buildbot/bin/python'} 14:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:31:39 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 14:31:39 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 14:31:39 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 14:31:39 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 14:31:39 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 14:31:39 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 14:31:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:31:41 INFO - Installing collected packages: mozsystemmonitor 14:31:41 INFO - Running setup.py install for mozsystemmonitor 14:31:41 INFO - Successfully installed mozsystemmonitor 14:31:41 INFO - Cleaning up... 14:31:41 INFO - Return code: 0 14:31:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:41 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')]} 14:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:41 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')]} 14:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:41 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 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:41 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 14:31:41 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 14:31:41 INFO - Using env: {'DISPLAY': ':0', 14:31:41 INFO - 'HOME': '/home/cltbld', 14:31:41 INFO - 'LANG': 'en_US.UTF-8', 14:31:41 INFO - 'LANGUAGE': 'en_US:en', 14:31:41 INFO - 'LOGNAME': 'cltbld', 14:31:41 INFO - 'MAIL': '/var/mail/cltbld', 14:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:41 INFO - 'MOZ_NO_REMOTE': '1', 14:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:41 INFO - 'NO_EM_RESTART': '1', 14:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:41 INFO - 'PWD': '/builds/slave/test', 14:31:41 INFO - 'SHELL': '/bin/bash', 14:31:41 INFO - 'SHLVL': '1', 14:31:41 INFO - 'TERM': 'linux', 14:31:41 INFO - 'TMOUT': '86400', 14:31:41 INFO - 'USER': 'cltbld', 14:31:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:41 INFO - '_': '/tools/buildbot/bin/python'} 14:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:41 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 14:31:41 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 14:31:41 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 14:31:41 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 14:31:41 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 14:31:41 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 14:31:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:31:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:31:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:43 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 14:31:44 INFO - Downloading docopt-0.6.1.tar.gz 14:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:31:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:31:44 INFO - Running setup.py install for blobuploader 14:31:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:31:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:31:44 INFO - Running setup.py install for requests 14:31:44 INFO - Running setup.py install for docopt 14:31:44 INFO - Successfully installed blobuploader requests docopt 14:31:44 INFO - Cleaning up... 14:31:44 INFO - Return code: 0 14:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:44 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 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:44 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 14:31:44 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 14:31:44 INFO - Using env: {'DISPLAY': ':0', 14:31:44 INFO - 'HOME': '/home/cltbld', 14:31:44 INFO - 'LANG': 'en_US.UTF-8', 14:31:44 INFO - 'LANGUAGE': 'en_US:en', 14:31:44 INFO - 'LOGNAME': 'cltbld', 14:31:44 INFO - 'MAIL': '/var/mail/cltbld', 14:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:44 INFO - 'MOZ_NO_REMOTE': '1', 14:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:44 INFO - 'NO_EM_RESTART': '1', 14:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:44 INFO - 'PWD': '/builds/slave/test', 14:31:44 INFO - 'SHELL': '/bin/bash', 14:31:44 INFO - 'SHLVL': '1', 14:31:44 INFO - 'TERM': 'linux', 14:31:44 INFO - 'TMOUT': '86400', 14:31:44 INFO - 'USER': 'cltbld', 14:31:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:44 INFO - '_': '/tools/buildbot/bin/python'} 14:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:44 INFO - Running setup.py (path:/tmp/pip-okhr08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:44 INFO - Running setup.py (path:/tmp/pip-x5jWE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:45 INFO - Running setup.py (path:/tmp/pip-3m8kCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:45 INFO - Running setup.py (path:/tmp/pip-ctkBqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:45 INFO - Running setup.py (path:/tmp/pip-8D08OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:45 INFO - Running setup.py (path:/tmp/pip-IJwnU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:45 INFO - Running setup.py (path:/tmp/pip-w8Qi7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:45 INFO - Running setup.py (path:/tmp/pip-BRaExa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:45 INFO - Running setup.py (path:/tmp/pip-3cP2vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:45 INFO - Running setup.py (path:/tmp/pip-P7DrI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:45 INFO - Running setup.py (path:/tmp/pip-G4xLhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:45 INFO - Running setup.py (path:/tmp/pip-PEzgOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:45 INFO - Running setup.py (path:/tmp/pip-43pH2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:45 INFO - Running setup.py (path:/tmp/pip-FACdWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:45 INFO - Running setup.py (path:/tmp/pip-sz8gNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:45 INFO - Running setup.py (path:/tmp/pip-ylopjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:46 INFO - Running setup.py (path:/tmp/pip-squZPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:31:46 INFO - Running setup.py install for manifestparser 14:31:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozcrash 14:31:46 INFO - Running setup.py install for mozdebug 14:31:46 INFO - Running setup.py install for mozdevice 14:31:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozfile 14:31:46 INFO - Running setup.py install for mozhttpd 14:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozinfo 14:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozInstall 14:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:31:46 INFO - Running setup.py install for mozleak 14:31:46 INFO - Running setup.py install for mozlog 14:31:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Running setup.py install for moznetwork 14:31:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Running setup.py install for mozprocess 14:31:47 INFO - Running setup.py install for mozprofile 14:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Running setup.py install for mozrunner 14:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Running setup.py install for mozscreenshot 14:31:47 INFO - Running setup.py install for moztest 14:31:47 INFO - Running setup.py install for mozversion 14:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:31:47 INFO - Cleaning up... 14:31:47 INFO - Return code: 0 14:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:47 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 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:47 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 14:31:47 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 14:31:47 INFO - Using env: {'DISPLAY': ':0', 14:31:47 INFO - 'HOME': '/home/cltbld', 14:31:47 INFO - 'LANG': 'en_US.UTF-8', 14:31:47 INFO - 'LANGUAGE': 'en_US:en', 14:31:47 INFO - 'LOGNAME': 'cltbld', 14:31:47 INFO - 'MAIL': '/var/mail/cltbld', 14:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:47 INFO - 'MOZ_NO_REMOTE': '1', 14:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:47 INFO - 'NO_EM_RESTART': '1', 14:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:47 INFO - 'PWD': '/builds/slave/test', 14:31:47 INFO - 'SHELL': '/bin/bash', 14:31:47 INFO - 'SHLVL': '1', 14:31:47 INFO - 'TERM': 'linux', 14:31:47 INFO - 'TMOUT': '86400', 14:31:47 INFO - 'USER': 'cltbld', 14:31:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:47 INFO - '_': '/tools/buildbot/bin/python'} 14:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:31:48 INFO - Running setup.py (path:/tmp/pip-Bf5Tsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:31:48 INFO - Running setup.py (path:/tmp/pip-QvynWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:31:48 INFO - Running setup.py (path:/tmp/pip-iKxk0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:31:48 INFO - Running setup.py (path:/tmp/pip-asouCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:31:48 INFO - Running setup.py (path:/tmp/pip-jRJ5ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:31:48 INFO - Running setup.py (path:/tmp/pip-po63A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:31:48 INFO - Running setup.py (path:/tmp/pip-Xw1BJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:31:48 INFO - Running setup.py (path:/tmp/pip-5p4RvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:31:48 INFO - Running setup.py (path:/tmp/pip-rGMOdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:31:48 INFO - Running setup.py (path:/tmp/pip-yuONPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:31:48 INFO - Running setup.py (path:/tmp/pip-0C6jZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:31:48 INFO - Running setup.py (path:/tmp/pip-N9rNqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:31:48 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)) 14:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:31:48 INFO - Running setup.py (path:/tmp/pip-wKg6YB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:31:49 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)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:31:49 INFO - Running setup.py (path:/tmp/pip-kV0Han-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:31:49 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)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:49 INFO - Running setup.py (path:/tmp/pip-6ml8IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:31:49 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)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:31:49 INFO - Running setup.py (path:/tmp/pip-ubEeMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:31:49 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)) 14:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:31:49 INFO - Running setup.py (path:/tmp/pip-fDZL5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:31:49 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)) 14:31:49 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)) 14:31:49 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)) 14:31:49 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)) 14:31:49 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)) 14:31:49 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)) 14:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:31: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 14:31:49 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 14:31:49 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 14:31:49 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 14:31: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 14:31:49 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 14:31:51 INFO - Downloading blessings-1.6.tar.gz 14:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:31:51 INFO - Installing collected packages: blessings 14:31:51 INFO - Running setup.py install for blessings 14:31:51 INFO - Successfully installed blessings 14:31:51 INFO - Cleaning up... 14:31:51 INFO - Return code: 0 14:31:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:31:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:51 INFO - Reading from file tmpfile_stdout 14:31:51 INFO - Current package versions: 14:31:51 INFO - argparse == 1.2.1 14:31:51 INFO - blessings == 1.6 14:31:51 INFO - blobuploader == 1.2.4 14:31:51 INFO - docopt == 0.6.1 14:31:51 INFO - manifestparser == 1.1 14:31:51 INFO - mozInstall == 1.12 14:31:51 INFO - mozcrash == 0.17 14:31:51 INFO - mozdebug == 0.1 14:31:51 INFO - mozdevice == 0.48 14:31:51 INFO - mozfile == 1.2 14:31:51 INFO - mozhttpd == 0.7 14:31:51 INFO - mozinfo == 0.9 14:31:51 INFO - mozleak == 0.1 14:31:51 INFO - mozlog == 3.1 14:31:51 INFO - moznetwork == 0.27 14:31:51 INFO - mozprocess == 0.22 14:31:51 INFO - mozprofile == 0.28 14:31:51 INFO - mozrunner == 6.11 14:31:51 INFO - mozscreenshot == 0.1 14:31:51 INFO - mozsystemmonitor == 0.0 14:31:51 INFO - moztest == 0.7 14:31:51 INFO - mozversion == 1.4 14:31:51 INFO - psutil == 3.1.1 14:31:51 INFO - requests == 1.2.3 14:31:51 INFO - wsgiref == 0.1.2 14:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:51 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 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:51 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 14:31:51 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 14:31:51 INFO - Using env: {'DISPLAY': ':0', 14:31:51 INFO - 'HOME': '/home/cltbld', 14:31:51 INFO - 'LANG': 'en_US.UTF-8', 14:31:51 INFO - 'LANGUAGE': 'en_US:en', 14:31:51 INFO - 'LOGNAME': 'cltbld', 14:31:51 INFO - 'MAIL': '/var/mail/cltbld', 14:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:51 INFO - 'MOZ_NO_REMOTE': '1', 14:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:51 INFO - 'NO_EM_RESTART': '1', 14:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:51 INFO - 'PWD': '/builds/slave/test', 14:31:51 INFO - 'SHELL': '/bin/bash', 14:31:51 INFO - 'SHLVL': '1', 14:31:51 INFO - 'TERM': 'linux', 14:31:51 INFO - 'TMOUT': '86400', 14:31:51 INFO - 'USER': 'cltbld', 14:31:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:51 INFO - '_': '/tools/buildbot/bin/python'} 14:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 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)) 14:31:51 INFO - Cleaning up... 14:31:51 INFO - Return code: 0 14:31:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:31:51 INFO - Using env: {'DISPLAY': ':0', 14:31:51 INFO - 'HOME': '/home/cltbld', 14:31:51 INFO - 'LANG': 'en_US.UTF-8', 14:31:51 INFO - 'LANGUAGE': 'en_US:en', 14:31:51 INFO - 'LOGNAME': 'cltbld', 14:31:51 INFO - 'MAIL': '/var/mail/cltbld', 14:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:51 INFO - 'MOZ_NO_REMOTE': '1', 14:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:51 INFO - 'NO_EM_RESTART': '1', 14:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:51 INFO - 'PWD': '/builds/slave/test', 14:31:51 INFO - 'SHELL': '/bin/bash', 14:31:51 INFO - 'SHLVL': '1', 14:31:51 INFO - 'TERM': 'linux', 14:31:51 INFO - 'TMOUT': '86400', 14:31:51 INFO - 'USER': 'cltbld', 14:31:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:51 INFO - '_': '/tools/buildbot/bin/python'} 14:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:52 INFO - Downloading/unpacking jsonschema 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:52 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 14:31:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:31:53 INFO - Downloading/unpacking functools32 (from jsonschema) 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:53 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 14:31:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:31:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:31:54 INFO - warning: no files found matching '*.txt' 14:31:54 INFO - no previously-included directories found matching 'build' 14:31:54 INFO - no previously-included directories found matching 'dist' 14:31:54 INFO - no previously-included directories found matching '.git*' 14:31:54 INFO - Installing collected packages: jsonschema, functools32 14:31:54 INFO - Running setup.py install for functools32 14:31:54 INFO - warning: no files found matching '*.txt' 14:31:54 INFO - no previously-included directories found matching 'build' 14:31:54 INFO - no previously-included directories found matching 'dist' 14:31:54 INFO - no previously-included directories found matching '.git*' 14:31:54 INFO - Successfully installed jsonschema functools32 14:31:54 INFO - Cleaning up... 14:31:54 INFO - Return code: 0 14:31:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:31: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')]} 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0004241f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', '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 14:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:31:54 INFO - Using env: {'DISPLAY': ':0', 14:31:54 INFO - 'HOME': '/home/cltbld', 14:31:54 INFO - 'LANG': 'en_US.UTF-8', 14:31:54 INFO - 'LANGUAGE': 'en_US:en', 14:31:54 INFO - 'LOGNAME': 'cltbld', 14:31:54 INFO - 'MAIL': '/var/mail/cltbld', 14:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:54 INFO - 'MOZ_NO_REMOTE': '1', 14:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:31:54 INFO - 'NO_EM_RESTART': '1', 14:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:54 INFO - 'PWD': '/builds/slave/test', 14:31:54 INFO - 'SHELL': '/bin/bash', 14:31:54 INFO - 'SHLVL': '1', 14:31:54 INFO - 'TERM': 'linux', 14:31:54 INFO - 'TMOUT': '86400', 14:31:54 INFO - 'USER': 'cltbld', 14:31:54 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:54 INFO - '_': '/tools/buildbot/bin/python'} 14:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:54 INFO - Downloading/unpacking flake8 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:31:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:31:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:56 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 14:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:31:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:57 INFO - no previously-included directories found matching 'docs/_build' 14:31:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:31:57 INFO - Running setup.py install for pep8 14:31:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:31:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:31:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:31:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:31:57 INFO - no previously-included directories found matching 'docs/_build' 14:31:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:31:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:31:57 INFO - Cleaning up... 14:31:57 INFO - Return code: 0 14:31:57 INFO - Running post-action listener: _resource_record_post_action 14:31:57 INFO - Running post-action listener: _start_resource_monitoring 14:31:57 INFO - Starting resource monitoring. 14:31:57 INFO - ##### 14:31:57 INFO - ##### Running install step. 14:31:57 INFO - ##### 14:31:57 INFO - Running pre-action listener: _resource_record_pre_action 14:31:57 INFO - Running main action method: install 14:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:31:57 INFO - Reading from file tmpfile_stdout 14:31:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:31:57 INFO - Reading from file tmpfile_stdout 14:31:57 INFO - Output received: 14:31:57 INFO - Usage: mozinstall [options] installer 14:31:57 INFO - Options: 14:31:57 INFO - -h, --help show this help message and exit 14:31:57 INFO - -d DEST, --destination=DEST 14:31:57 INFO - Directory to install application into. [default: 14:31:57 INFO - "/builds/slave/test"] 14:31:57 INFO - --app=APP Application being installed. [default: firefox] 14:31:57 INFO - mkdir: /builds/slave/test/build/application 14:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:32:13 INFO - Reading from file tmpfile_stdout 14:32:13 INFO - Output received: 14:32:13 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:13 INFO - Running post-action listener: _resource_record_post_action 14:32:13 INFO - ##### 14:32:13 INFO - ##### Running run-tests step. 14:32:13 INFO - ##### 14:32:13 INFO - Running pre-action listener: _resource_record_pre_action 14:32:13 INFO - Running main action method: run_tests 14:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:13 INFO - Python 2.7.3 14:32:13 INFO - Return code: 0 14:32:13 INFO - grabbing minidump binary from tooltool 14:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:13 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05410>, '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 0xe06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe067a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:13 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 14:32:13 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 14:32:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:13 INFO - Return code: 0 14:32:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:14 INFO - Return code: 0 14:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 14:32:14 INFO - Using env: {'DISPLAY': ':0', 14:32:14 INFO - 'HOME': '/home/cltbld', 14:32:14 INFO - 'LANG': 'en_US.UTF-8', 14:32:14 INFO - 'LANGUAGE': 'en_US:en', 14:32:14 INFO - 'LOGNAME': 'cltbld', 14:32:14 INFO - 'MAIL': '/var/mail/cltbld', 14:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:14 INFO - 'MOZ_NO_REMOTE': '1', 14:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:14 INFO - 'NO_EM_RESTART': '1', 14:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:14 INFO - 'PWD': '/builds/slave/test', 14:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:14 INFO - 'SHELL': '/bin/bash', 14:32:14 INFO - 'SHLVL': '1', 14:32:14 INFO - 'TERM': 'linux', 14:32:14 INFO - 'TMOUT': '86400', 14:32:14 INFO - 'USER': 'cltbld', 14:32:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425', 14:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:14 INFO - '_': '/tools/buildbot/bin/python'} 14:32:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 14:32:14 INFO - mozversion application_buildid: 20160415134642 14:32:14 INFO - mozversion application_changeset: 6a623b9d45990722da19fc864c7ef820821bd4b0 14:32:14 INFO - mozversion application_display_name: Nightly 14:32:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:14 INFO - mozversion application_name: Firefox 14:32:14 INFO - mozversion application_remotingname: firefox 14:32:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:14 INFO - mozversion application_vendor: Mozilla 14:32:14 INFO - mozversion application_version: 48.0a1 14:32:14 INFO - mozversion platform_buildid: 20160415134642 14:32:14 INFO - mozversion platform_changeset: 6a623b9d45990722da19fc864c7ef820821bd4b0 14:32:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:14 INFO - mozversion platform_version: 48.0a1 14:32:14 INFO - using testdate: 1460755934 14:32:14 INFO - actual date: 1460755934 14:32:14 INFO - starting webserver on 'localhost:41777' 14:32:14 INFO - SUITE-START | Running 2 tests 14:32:14 INFO - TEST-START | dromaeo_css 14:32:14 INFO - operating with platform_type : linux_ 14:32:14 INFO - Initialising browser for dromaeo_css test... 14:32:14 INFO - TEST-INFO | started process 25511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PAEfn/profile http://localhost:41777/getInfo.html) 14:32:18 INFO - PROCESS | 25511 | 14:32:18 INFO - PROCESS | 25511 | (process:25579): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:32:18 INFO - PROCESS | 25511 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:32:19 INFO - PROCESS | 25511 | __metrics Screen width/height:1600/1200 14:32:19 INFO - PROCESS | 25511 | colorDepth:24 14:32:19 INFO - PROCESS | 25511 | Browser inner width/height: 1024/697 14:32:19 INFO - PROCESS | 25511 | __metrics 14:32:20 ERROR - PROCESS | 25511 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:32:20 INFO - TEST-INFO | 25511: exit 0 14:32:20 INFO - Browser initialized. 14:32:20 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:20 INFO - TEST-INFO | started process 25630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PAEfn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:22 INFO - PROCESS | 25630 | 14:32:22 INFO - PROCESS | 25630 | (process:25687): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:32:32 INFO - PROCESS | 25630 | RSS: Main: 165052416 14:32:32 INFO - PROCESS | 25630 | 14:33:22 INFO - PROCESS | 25630 | 1460756002330 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] 14:35:33 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41777/tests/dromaeo/cssquery-ext.html) 14:35:34 INFO - PROCESS | 25630 | RSS: Main: 167149568 14:35:34 INFO - PROCESS | 25630 | 14:38:36 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-ext.html (next: http://localhost:41777/tests/dromaeo/cssquery-jquery.html) 14:38:37 INFO - PROCESS | 25630 | RSS: Main: 165769216 14:38:37 INFO - PROCESS | 25630 | 14:41:39 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41777/tests/dromaeo/cssquery-mootools.html) 14:41:40 INFO - PROCESS | 25630 | RSS: Main: 166801408 14:41:40 INFO - PROCESS | 25630 | 14:44:41 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41777/tests/dromaeo/cssquery-prototype.html) 14:44:42 INFO - PROCESS | 25630 | RSS: Main: 164904960 14:44:42 INFO - PROCESS | 25630 | 14:47:45 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41777/tests/dromaeo/cssquery-yui.html) 14:47:45 INFO - PROCESS | 25630 | RSS: Main: 165638144 14:47:45 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | Cycle 1(1): loaded http://localhost:41777/tests/dromaeo/cssquery-yui.html (next: http://localhost:41777/tests/dromaeo/cssquery-dojo.html) 14:50:48 INFO - PROCESS | 25630 | RSS: Main: 167985152 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | __start_tp_report 14:50:48 INFO - PROCESS | 25630 | _x_x_mozilla_page_load 14:50:48 INFO - PROCESS | 25630 | _x_x_mozilla_page_load_details 14:50:48 INFO - PROCESS | 25630 | |i|pagename|runs| 14:50:48 INFO - PROCESS | 25630 | |0;dojo.html;2578.587426011838;2625.737426257376;2633.7234590368016;2662.0283596487275;2670.2923725212822;4589.7016693914875;4639.002614437895;4653.8603841884715;4692.953070469294;4731.621470282378;4535.092981403716;4674.55591718787;4708.552687494683;4754.215554433515;4787.952120478794;4299.46256717911;4406.317020861756;4409.184300904343;4417.514073451934;4420.248557745175;522.0726109836348;4191.245575796355;4215.620594146526;4240.265299495187;4262.147570485899;4361.890952726176;4363.956360436387;4372.1255748850035;4387.166438376714;4393.802278897458;4328.913421731548;4369.213541562517;4377.715448495869;4379.4525684289465;4413.3159360299205;4271.700980931336;4326.935095973563;4330.285502892019;4358.6730995175485;4381.036172042146;4575.885602859955;4597.977010114928;4600.332951722015;4600.493945665974;4626.537346265381;4707.811687532495;4889.3888263967;5012.949870501321;5029.547340739351;5042.647014708972;5007.223880298559;5041.697498150123;5042.39491261051;5071.898562028776;5089.923651145199;4648.744319062416;4649.1863923813535;4694.718316900997;4699.718016918996;4736.550027747393;4978.4025916890205;5171.896562068738;5193.922091168635;5213.400458947193;5290.761915713802;4953.108440480748;4975.203967365276;4975.577075948512;4976.502349765067;4999.825006124768;5034.697918124924;5036.219385995177;5045.091883461012;5053.191489361684;5067.011932673094;4803.519648035169;4949.950500495021;4984.825531106394;5022.723750193774;5029.874253143627;4860.465348811628;4900.264960255919;4924.015196960622;4927.334809800703;4985.8005679772405;4196.412502249687;4207.97896010518;4210.705250632487;4213.810378532973;4242.17277630859;3577.928441431157;3581.28374325136;3609.151849315409;3697.759645623026;3732.925341493209;4272.957270427318;4289.099289149313;4296.226679197712;4326.307790753464;4334.414853994734;5060.342155519759;5080.390353157571;5086.796528138833;5097.337346144977;5138.023775482647;4193.832246710159;4253.8723838284905;4263.062126332202;4268.722533035343;4378.934315985262;4480.977595112004;4509.594136527729;4526.02690421561;4553.043860789205;4576.130535198302;4714.905701886011;4715.481297057389;4722.905541889074;4725.07860967115;4753.928691069567;4847.345608342828;5003.524665156804;5005.899882002413;5064.240363945438;5075.0357432087785;4771.904561908673;4784.497627749175;4786.922942337947;4800.567948884617;4836.250381190921;4933.013397320622;4983.152864013199;4983.476734942778;4992.950070499249;5040.243963405372;4822.204336284473;5042.117629414911;5043.646944713982;5093.796248150033;5118.411382691038;4815.518448155297;4841.564259216688;4856.320115183948;4880.292357608056;4901.803927842846;4868.245421959602;4877.926831097608;4880.682755620874;4888.242322439885;4948.6535942485125;4585.541445855388;4808.711477311373;4818.10864989978;4871.48849370811;4872.658913875995;4900.799304170501;4918.163912134874;4943.65394422387;4951.554360107608;4981.651284410056;4838.927416088832;4840;4843.564079232886;4844.46710861812;4897.706137631753 14:50:48 INFO - PROCESS | 25630 | |1;ext.html;575.9222504961829;606.0636316890403;610.3560743415698;622.6139793328135;634.844463106539;33064.83467582665;33893;33980.66019339806;33984.490232646465;33984.66015339846;34600.1349966251;35419;35498.46752298718;35501.644983550155;35515;7407.814804629887;7522.887156692654;7533;7551.829466432711;7567.697292108309;7376.041114655088;7578.431617628672;7641.4268929830205;7646.120696119961;7653.617319134049;7651.885221721679;7681.078270607535;7690.5770182639935;7702.0757509098985;7719.228077192264;7587.962060189691;7599.012128423297;7612;7618.085829700443;7632.389408847279;7595.050618672666;7695.461317707763;7696.7306144284685;7697.268759467842;7701.653425595861;29211.269718257;34134.14664633379;34400;34691.826540867136;34722.13194670128;3053.0993356959752;3128.671489493593;3157.5579418881375;3205.4390481665614;3285.7042866141924;24004.15985440501;24215.87892060546;24245.636315455282;24885.62671559928;25153.24540263795;2727.4954133485367;2758.462099890522;2789.2190186747744;2804.354998350391;2871.9804469413475;151908;152485;152545;153511.23244383818;183835.99999999866;31570.526442103386;31608;31801.52297715536;32371.19072023218;33336.33327333488;31367.68632313693;31530.369392612018;31641.050768476984;31751.68248317487;31763.52354714681;12715.491380344683;12889.742205155844;12903.870961290455;12910.548130815376;12976.610701678965;9525.095115963972;9599.856002159973;9608.423494590346;9655.372400793925;9685.370450920667;8131.105578386373;8158;8164.224398682116;8194;8238.217369349903;3178.936421271562;3202.119417160253;3207.486802111651;3219.323941972212;3224.5324427958285;941.0730430525927;941.4116177389132;944.9622015119318;987.2554299048657;987.8814542254831;27009.459810803673;27964;28088.29779255535;28119.156425307272;28643.713562864104;1034.1933292032227;1069.6790962711154;1075.8816530181673;1077.9299345542515;1135.6990397544657;14495.565133046026;14994.400223991137;15039.323230454656;15090.849091508944;15158.848411515964;345095;348028;351847;352374;353454;47978.28032579514;48610.27084593734;48625.75687121542;48755;48906.26640600394;1232.8890399864056;1268.4355461819587;1277.6933535951491;1279.539365828301;1282.4165004922552;26354;27242.45515089727;27445.176644700692;27540.330611432466;27874;43119.78440107779;43857.78071109624;43919;43932;44100.55899440964;309175;315518;316099;316777;319571;25350.069790430225;25458;25689.100881469807;25744.61383079218;25808.612870806577;40503.79748101241;41102.79448602738;41135.1772964545;41733.791331043154;41983;36268.917142043225;36703.265934681694;36799.816000919825;37029.81485092557;37494.250114998096;35438.64561354354;35726.28547429089;35983.64016359803;36238.275234494635;36295.818520907225;31953.840230798698;35216.64783352134;35752.463713043806;35965.28069438649;36526.634733652325;27304.180874573794;29239.561406579345;29864.552031719108;29976;31404.214894627818;24326.51346973015;24357.51284974255;24794.380140496633;25055.87472062701;25304.493910122063 14:50:48 INFO - PROCESS | 25630 | |2;jquery.html;382.711053154868;382.8774792066539;385.76468354303876;394.84601005607817;402.4506548561215;15289.464868729598;16562.66874662509;17139.400120995768;17234.482965511055;17405.129743512807;15406.152661603608;15545.53363399097;15706.528804135865;15757.369705211806;15813.60465988348;5108.69347839129;5263.86840328991;5271.235670827747;5285.233641122035;5305.602079844027;3702.962970370302;5772.163036359725;6077.696115194245;6079.088136779496;6135.9079613805825;4998.425181104165;6009.699515024253;6014.669193194372;6015.669138197398;6070.696465176746;5228.738563071869;5232.947670523303;5251.002309561171;5256.526912577867;5273.182656688219;4988.603191106496;5392.946070539284;5461.290032295816;5461.918071228934;5469.179623056573;11970.82043769344;12453.315067671274;12631.621051368382;12645.557405490763;12731.490740370375;1941.5148609779505;1993.157816450995;2160.8487405881597;2172.196287373666;2349.929502114939;9214.723558293195;9292.210162136227;9643.421394716339;11754.29474231549;12513.499460021589;1824.9908750456163;1873.9156737946826;1884.7361369408293;1903.961920761577;1920.9626801527158;66140.6692966537;69090.61818763596;69592.65203674;69643.65178174127;70031.2996870035;9928;9960.505924111441;10169.830369548597;10280.485975701185;10414.323069000491;14465.13209207451;14562.635934101732;14566.854331456761;14588.416463341347;14593.92703036478;6921.792346229621;7018.859622807515;7097.432205423554;7101.467389945775;7148;6356.523260755369;6388.39310265524;6396.5202609804455;6501.544891857525;6534.509911756637;4391.275439552502;4411.2721400968485;4462.665300102505;4500.167469018242;4505.256632655641;1693.4073074423852;1836.0701516428433;1916.4633902507321;1927.0557426861017;1927.8554108441922;944.8236945003515;953.1850268020743;971.7813491964392;981.5141504954951;1005.331454582709;16531.090790006423;16762.58093547671;16808.159592020595;16830;17043.65912681764;836.4855613797471;869.5608717597572;882.4264228251687;972.2805124208035;978.7699890525721;8797.296216302808;9153.908460915438;9163.95418022919;9189.981454523679;9252.491112988715;441624;444409;446333;450157;456526;68835.3116468829;72342;78772.60613697009;82399.17600824035;82893.58553207196;973.3089506450358;975.970351279407;1016.3444578246989;1048.9423081730426;1060.8143574874366;14829.925850370679;15078.472253471076;15181.392744290104;15323.157226352658;16073.35706571724;34150.82924585361;34274;34738.478922816685;35234.647653523134;35542.46686299759;49286.01427971349;49363.012739744285;49928.75035624798;49980;50638;7665.3101220890385;7818.313121000166;7906.644201011083;7930.405219608437;8007.679692812222;8728.476291422536;10836.945815271189;11476.540938362372;11499.367534785668;11650.88349116498;9772.364796288219;9864.901350986398;10103.848442273225;10327.948360258151;10444.903285155253;9454.440017397328;10261.486925653837;10531.210159237935;10557.15542756593;10738.516766745672;9758.316917815968;10026.69919902404;10500.894991050298;10750.354978701303;10760.300580462244;6695.196576410862;7098.254683258184;7840.0199975003125;7849.921500784919;7853.685852565834;9761.121499065119;10464.162866970471;10698.73253168677;10785.838212426977;10900.182486313399 14:50:48 INFO - PROCESS | 25630 | |3;mootools.html;1446.0672866001426;1480.8000919875815;1598.888077834552;1755.3943889358175;1758.7977382600989;6825.6928438220275;7725.497842640231;7884.763457096282;7980.9201907980905;8015.278624923763;7861.056673199224;7911.802204944879;7936.722214722486;7946.443748937577;7960.08459027212;2228.999999999996;2238.3620668109593;2252.054137262354;2257.0858802185057;2259.164109279569;2213.380253529014;2267.501149747053;2277.0095008671283;2277.6925115109416;2299.1952816514254;2271.1483193802324;2289.301762962296;2293.2776175504746;2303.3090072978125;2306.1928325086255;2217.4013016485537;2218.3234113595345;2222.688823564702;2228.3649159989327;2230.8549944253655;2230.375494861425;2248.3592176229695;2256.345659758668;2260.412292803883;2268.3421807675754;8055.798605034863;8068;8077.555734434603;8107.22981316774;8142.674293028272;4713.835015774465;4842.66101372904;4849.636277279218;4879.560839524424;4887.975560122212;2882.9711702882914;2975.717306855867;3015.3064795097252;3018.607581014454;3032.150997720642;1608.6139326561658;1674.7655328254054;1693.9068351240676;1712.6403455274408;1721.4233231867215;10892.292001019909;11021.724456888562;11088.112950963903;11106.777864442665;11134.554617815278;4217.304144816071;4224.577542245751;4308.633766129914;4324.632406245504;4351.5430879757805;8770.298376129895;8791.296696264284;8852.159044890725;8856.911430885737;8865.335099867536;4695.741734204652;4699.389079419653;4708.176069187878;4709.646776491777;4719.669623126349;3780.111673756665;4215.494140703136;4297.5702429756775;4298.849540266076;4353.69524133314;3534.3991521441417;3581.8209089545417;3636.1636823530735;3642.5446819147605;3722.8324725387424;1094.8631421072366;1097.1661537231762;1105.0883021507289;1109.051760744568;1109.1404161774528;734.9265073492608;863.1627321498137;874.4403581707712;890.1143362354499;891.5542228885557;5218.399884013387;5263.157894736823;5331.360236771612;5396.703181324986;5490.478404551562;412.69460599156406;416.9249535083653;427.5553424438549;433.10347580508676;436.91698577270216;3634.2731453708834;3725.590185079639;3737.5328083989502;3741.8690345837763;3799.886003419902;9761.219102471927;10062.345947513388;10208.234382421348;10208.948955255177;10239.539220734936;9988.700338989842;9994.350367226107;10051.346662466916;10053.497325133714;10112.191024718006;6889.069975553336;7335.7432489862595;7373.33639972405;7398.0012698285045;7442.516236444614;5367.248585197997;5368.570514358764;5526.696031718294;5548.500634942875;5605;8987.55062246872;9004.054574269869;9118.544072796467;9142.405743626643;9196.632134714537;8857;9070.773230669287;9257.120573545502;9345.953270233877;9388.530573471437;6884.242733299233;7411.107170863229;7610.12483564375;7629.54222746637;7636.656350464354;7643.312101910855;7711.151773305044;7739.148693643582;7742.729004484816;7754.92245077542;6876.69054892541;6943.236244013054;7001.544899581511;7099.503034787515;7142.678579463833;6657.800265992028;6821.420179284618;6844.110265665432;6969.442444604318;7041.049458323061;6437.452816510462;6522.287948914797;6542.934570654233;6562.639054851838;6578.572392794453;4471.709338892962;4509.50395456493;4524.41182646267;4607.378003969421;4778.068276686013;4583.991521865184;4593.586577208067;4639.396878405786;4791.5687588117235;4803.1354356214815 14:50:48 INFO - PROCESS | 25630 | |4;prototype.html;312.7794904592263;318.86288895774805;320.5960489782873;321.94205043092234;322.2716660347615;5347.9783922084;5417.566594672427;5430.15832545955;5460.563154947609;5477.945220547794;5336.546393556552;5371.973140134303;5382.354117505895;5383.650062745928;5388.407275199725;3962.286788378091;4087.305158123126;4199.55904630014;4212.641925436342;4226.492820861501;4224.97887510562;4227;4238.554951730071;4241.87274381769;4245.554216807222;4153.397757325186;4185.434966279559;4207.200631879949;4217.072244106292;4217.599328063844;4061.4720086388875;4169.519820463722;4203.663706903471;4206.326987681956;4208.389783481393;3661.5972243053243;3682.226732386175;3682.987178525927;3683.1528748387755;3697.2975134724315;5152.531528514392;5163.406208286057;5172.250023746536;5201.349831271091;5235.293235413209;4727.463574338354;4809.302651115604;4853.708777473363;4855.781489832966;4865.124277630025;5672.12082127271;5701.230333904953;5709.371969083398;5720.742566584514;5727.255456790591;4021.8994525136814;4056.2090392373498;4067.5118985721606;4069.552349241581;4073.103917138225;5702.600817942745;5944.167816505649;5962.736643300062;5975.492083172936;6001.639901605874;4098.918021639551;4117.958820411757;4131.752094874317;4144.052295421147;4149.738392575993;4202.831886724558;4217.36739489073;4222.619964203175;4224.8098835551855;4231.19607274623;4643.396358473445;4735.289706544046;4763.54746299101;4786.2581299898575;4796.712197268175;5605.383407825136;5657.236273103161;5670.631408958405;5670.971645141748;5707.143928410772;1458.0741229319458;1466.3914475492763;1478.9556313310618;1484.6362641152987;1490.4857824050684;915.4278575890069;982.7248370456284;982.7690492734201;1004.6082028009082;1024;4821.228603423436;4856.902861942812;4904.386951631046;4910.582600479;4932.482089380564;5824.854378640568;5827.708614569339;5832.88334233313;5848.707564621752;5866.67733274674;4816.373871396766;4877.463479017305;4888.902221955541;4907.214845624683;4914.950850491521;3105.509355509368;3110.0980715592677;3117.828519431453;3134.9373012539622;3155.763317751178;5447.420248128078;5473.425290344536;5482.068048431776;5492.505674489315;5512.834614961557;5806.2451881255165;5986.700664966735;5990.820275391745;6025.4577088061405;6029.638221706624;5437.39005277469;5471.179323101487;5493.670379777226;5495.945040549544;5512.889742205133;5662.858428539154;5850.912236316543;5853.970730146322;5866.090755932837;5883.764649413975;5707.886962042528;5712.7714891403875;5713.257276554022;5732.5031730645105;5738.799142030009;5479.821838304624;5490.6431081979545;5507.449255074461;5517.337919449692;5527.640703354269;4069.5320038195987;4140.171965606831;4167.4790651168605;4181.665466762713;4208.263553878121;5771.192033115283;5774.682392468455;5791.901332786939;5792.4497172768515;5834.649921004753;5624.775008999594;5635.492805647511;5635.88728225425;5639;5641.717914104361;5374.677519348852;5758.280214973129;5764.164196191445;5772.39389864075;5773.9895518284975;5301.701083234632;5623.943760562342;5663.631863928997;5675.943240567542;5676.262085928803;5538.833834984957;5706.144078388109;5719.942800571941;5728.742206600797;5745.942540574708;5596.86007849807;5636.436356364331;5668.914966275427;5672.787612831082;5691.174779657009 14:50:48 INFO - PROCESS | 25630 | |5;yui.html;693.82574720653;738.944579156563;746.7199800074972;767.5394763142116;773.8026803165192;11316;11442.427878606057;11469.541218351256;11523.711907202323;11603.709907252323;11842.348670823101;11886.227395219305;11983.40082995849;12201.75596488072;12225.449854756534;622.5299898576591;788.1802924958037;795.296162895837;807.2169995104739;807.2855522862251;815.1725998111921;815.3966065111833;817.15832692327;817.3787921179917;818.9877151842727;860.8837806896051;862.1981557151846;862.3446180902528;862.9395942284043;864.9913500864974;852.9616167272487;854.5385491834402;854.5428195915156;855.5166331022983;857.9871301930476;617.3363634093367;618.709206672863;619.2476141488069;619.7737825693634;625.5964902637819;11995.340256285901;12056.276623402624;12058.638240852788;12078;12093.093018023683;12848.293343866084;13079.86920130796;13121.47514099435;13298.135621184592;13326.267055311953;10077.848832267522;10292.742681432948;10327.380357178594;10506.474676266156;10688.893111068868;3360.395128876801;3375.5274261603395;3398.4222682144095;3405.0636075079306;3490.89527314181;47964;47984.760076199396;48281.27578086332;48594.757026215;50426.999999999636;10264.435456049989;10311.74220644475;10435.791284174426;10439.686809395731;10483.213758968108;17515.386961456286;17697.734533982002;17734.556636083944;17777.46667599974;17804.198811053535;6911.75808846688;6968.44252459802;7002.299770023059;7093.82265443368;7108.040414543971;3813.1992281620614;3865.768053916774;3882.592327805596;3897.668698160688;3925.371940489508;2673.0777881630806;2749.8900043998415;2758.6965433802266;2802;2805.691373948864;495.4896456649657;495.55647695312496;498.08601216766914;503.85640092574175;505.2774532418603;468.39810843066493;572.2446370790517;576.9624974376652;605.9424354686298;622.6762083716442;7916.406269529693;8068.47554908929;8195.42632015765;8270;8369.372297077743;610.1518888744648;629.4209327418786;635.9841003974938;647.5402464250341;651.6220592056595;3776.905577360533;3835.463035175078;3871.3612253977776;3900.570937196906;3919.412088186795;51252.71868203325;53304.733476333146;53344.46655533473;53384;53484.73257633687;45132;46005.76997114993;46321.536784631724;46496.3025554617;46526.53473465222;39133.41299880504;40919.97700057522;41022.9999999994;41077.589224107374;42034.579654203066;7436.442266830118;7657.157712651492;7762.340201082971;7864.134945155914;7910.406719496176;25208.74791252064;26966;27263.182104536896;27818.191817531795;27947.720522794512;33627.83186084054;35963.64036359708;36672.63327366692;37090.25819483649;37313;10660.946695266473;10757.623483178051;10845.349279043283;10900.618478353219;10959.287646302964;11578.94210528942;11604.6518604442;11617.47721352558;11683.299002059903;11964.222325548812;10812.891871081189;10889.782204356026;11040.116790656888;11149.108071354434;11374.488148033524;10941.12471002302;11000.724981875517;11014.889851101387;11023.44882755875;11347.14896382791;9487.288453365887;10573.788524229627;10767.946160269148;10806.405647689453;10870.836937445787;8967.641294348154;9069.138431848964;9073.45559266446;9167.724968250963;9341.252699783865;8958.68644597436;9297.116773906468;9443.102905223992;9484.620615175316;9569.952150239204 14:50:48 INFO - PROCESS | 25630 | __end_tp_report 14:50:48 INFO - PROCESS | 25630 | __start_cc_report 14:50:48 INFO - PROCESS | 25630 | _x_x_mozilla_cycle_collect,360 14:50:48 INFO - PROCESS | 25630 | __end_cc_report 14:50:48 INFO - PROCESS | 25630 | __startTimestamp1460757048292__endTimestamp 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | ------- Summary: start ------- 14:50:48 INFO - PROCESS | 25630 | Number of tests: 6 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#0] dojo.html Cycles:165 Average:4612.43 Median:4786.92 stddev:586.13 (12.2%) stddev-sans-first:565.80 14:50:48 INFO - PROCESS | 25630 | Values: 2578.6 2625.7 2633.7 2662.0 2670.3 4589.7 4639.0 4653.9 4693.0 4731.6 4535.1 4674.6 4708.6 4754.2 4788.0 4299.5 4406.3 4409.2 4417.5 4420.2 522.1 4191.2 4215.6 4240.3 4262.1 4361.9 4364.0 4372.1 4387.2 4393.8 4328.9 4369.2 4377.7 4379.5 4413.3 4271.7 4326.9 4330.3 4358.7 4381.0 4575.9 4598.0 4600.3 4600.5 4626.5 4707.8 4889.4 5012.9 5029.5 5042.6 5007.2 5041.7 5042.4 5071.9 5089.9 4648.7 4649.2 4694.7 4699.7 4736.6 4978.4 5171.9 5193.9 5213.4 5290.8 4953.1 4975.2 4975.6 4976.5 4999.8 5034.7 5036.2 5045.1 5053.2 5067.0 4803.5 4950.0 4984.8 5022.7 5029.9 4860.5 4900.3 4924.0 4927.3 4985.8 4196.4 4208.0 4210.7 4213.8 4242.2 3577.9 3581.3 3609.2 3697.8 3732.9 4273.0 4289.1 4296.2 4326.3 4334.4 5060.3 5080.4 5086.8 5097.3 5138.0 4193.8 4253.9 4263.1 4268.7 4378.9 4481.0 4509.6 4526.0 4553.0 4576.1 4714.9 4715.5 4722.9 4725.1 4753.9 4847.3 5003.5 5005.9 5064.2 5075.0 4771.9 4784.5 4786.9 4800.6 4836.3 4933.0 4983.2 4983.5 4993.0 5040.2 4822.2 5042.1 5043.6 5093.8 5118.4 4815.5 4841.6 4856.3 4880.3 4901.8 4868.2 4877.9 4880.7 4888.2 4948.7 4585.5 4808.7 4818.1 4871.5 4872.7 4900.8 4918.2 4943.7 4951.6 4981.7 4838.9 4840.0 4843.6 4844.5 4897.7 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#1] ext.html Cycles:180 Average:41353.23 Median:33984.58 stddev:75950.07 (223.5%) stddev-sans-first:76101.42 14:50:48 INFO - PROCESS | 25630 | Values: 575.9 606.1 610.4 622.6 634.8 33064.8 33893.0 33980.7 33984.5 33984.7 34600.1 35419.0 35498.5 35501.6 35515.0 7407.8 7522.9 7533.0 7551.8 7567.7 7376.0 7578.4 7641.4 7646.1 7653.6 7651.9 7681.1 7690.6 7702.1 7719.2 7588.0 7599.0 7612.0 7618.1 7632.4 7595.1 7695.5 7696.7 7697.3 7701.7 29211.3 34134.1 34400.0 34691.8 34722.1 3053.1 3128.7 3157.6 3205.4 3285.7 24004.2 24215.9 24245.6 24885.6 25153.2 2727.5 2758.5 2789.2 2804.4 2872.0 151908.0 152485.0 152545.0 153511.2 183836.0 31570.5 31608.0 31801.5 32371.2 33336.3 31367.7 31530.4 31641.1 31751.7 31763.5 12715.5 12889.7 12903.9 12910.5 12976.6 9525.1 9599.9 9608.4 9655.4 9685.4 8131.1 8158.0 8164.2 8194.0 8238.2 3178.9 3202.1 3207.5 3219.3 3224.5 941.1 941.4 945.0 987.3 987.9 27009.5 27964.0 28088.3 28119.2 28643.7 1034.2 1069.7 1075.9 1077.9 1135.7 14495.6 14994.4 15039.3 15090.8 15158.8 345095.0 348028.0 351847.0 352374.0 353454.0 47978.3 48610.3 48625.8 48755.0 48906.3 1232.9 1268.4 1277.7 1279.5 1282.4 26354.0 27242.5 27445.2 27540.3 27874.0 43119.8 43857.8 43919.0 43932.0 44100.6 309175.0 315518.0 316099.0 316777.0 319571.0 25350.1 25458.0 25689.1 25744.6 25808.6 40503.8 41102.8 41135.2 41733.8 41983.0 36268.9 36703.3 36799.8 37029.8 37494.3 35438.6 35726.3 35983.6 36238.3 36295.8 31953.8 35216.6 35752.5 35965.3 36526.6 27304.2 29239.6 29864.6 29976.0 31404.2 24326.5 24357.5 24794.4 25055.9 25304.5 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#2] jquery.html Cycles:180 Average:25595.11 Median:227328.58 stddev:73620.20 (32.4%) stddev-sans-first:73802.39 14:50:48 INFO - PROCESS | 25630 | Values: 382.7 382.9 385.8 394.8 402.5 15289.5 16562.7 17139.4 17234.5 17405.1 15406.2 15545.5 15706.5 15757.4 15813.6 5108.7 5263.9 5271.2 5285.2 5305.6 3703.0 5772.2 6077.7 6079.1 6135.9 4998.4 6009.7 6014.7 6015.7 6070.7 5228.7 5232.9 5251.0 5256.5 5273.2 4988.6 5392.9 5461.3 5461.9 5469.2 11970.8 12453.3 12631.6 12645.6 12731.5 1941.5 1993.2 2160.8 2172.2 2349.9 9214.7 9292.2 9643.4 11754.3 12513.5 1825.0 1873.9 1884.7 1904.0 1921.0 66140.7 69090.6 69592.7 69643.7 70031.3 9928.0 9960.5 10169.8 10280.5 10414.3 14465.1 14562.6 14566.9 14588.4 14593.9 6921.8 7018.9 7097.4 7101.5 7148.0 6356.5 6388.4 6396.5 6501.5 6534.5 4391.3 4411.3 4462.7 4500.2 4505.3 1693.4 1836.1 1916.5 1927.1 1927.9 944.8 953.2 971.8 981.5 1005.3 16531.1 16762.6 16808.2 16830.0 17043.7 836.5 869.6 882.4 972.3 978.8 8797.3 9153.9 9164.0 9190.0 9252.5 441624.0 444409.0 446333.0 450157.0 456526.0 68835.3 72342.0 78772.6 82399.2 82893.6 973.3 976.0 1016.3 1048.9 1060.8 14829.9 15078.5 15181.4 15323.2 16073.4 34150.8 34274.0 34738.5 35234.6 35542.5 49286.0 49363.0 49928.8 49980.0 50638.0 7665.3 7818.3 7906.6 7930.4 8007.7 8728.5 10836.9 11476.5 11499.4 11650.9 9772.4 9864.9 10103.8 10327.9 10444.9 9454.4 10261.5 10531.2 10557.2 10738.5 9758.3 10026.7 10500.9 10750.4 10760.3 6695.2 7098.3 7840.0 7849.9 7853.7 9761.1 10464.2 10698.7 10785.8 10900.2 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#3] mootools.html Cycles:180 Average:5283.96 Median:4703.78 stddev:2948.30 (62.7%) stddev-sans-first:2942.46 14:50:48 INFO - PROCESS | 25630 | Values: 1446.1 1480.8 1598.9 1755.4 1758.8 6825.7 7725.5 7884.8 7980.9 8015.3 7861.1 7911.8 7936.7 7946.4 7960.1 2229.0 2238.4 2252.1 2257.1 2259.2 2213.4 2267.5 2277.0 2277.7 2299.2 2271.1 2289.3 2293.3 2303.3 2306.2 2217.4 2218.3 2222.7 2228.4 2230.9 2230.4 2248.4 2256.3 2260.4 2268.3 8055.8 8068.0 8077.6 8107.2 8142.7 4713.8 4842.7 4849.6 4879.6 4888.0 2883.0 2975.7 3015.3 3018.6 3032.2 1608.6 1674.8 1693.9 1712.6 1721.4 10892.3 11021.7 11088.1 11106.8 11134.6 4217.3 4224.6 4308.6 4324.6 4351.5 8770.3 8791.3 8852.2 8856.9 8865.3 4695.7 4699.4 4708.2 4709.6 4719.7 3780.1 4215.5 4297.6 4298.8 4353.7 3534.4 3581.8 3636.2 3642.5 3722.8 1094.9 1097.2 1105.1 1109.1 1109.1 734.9 863.2 874.4 890.1 891.6 5218.4 5263.2 5331.4 5396.7 5490.5 412.7 416.9 427.6 433.1 436.9 3634.3 3725.6 3737.5 3741.9 3799.9 9761.2 10062.3 10208.2 10208.9 10239.5 9988.7 9994.4 10051.3 10053.5 10112.2 6889.1 7335.7 7373.3 7398.0 7442.5 5367.2 5368.6 5526.7 5548.5 5605.0 8987.6 9004.1 9118.5 9142.4 9196.6 8857.0 9070.8 9257.1 9346.0 9388.5 6884.2 7411.1 7610.1 7629.5 7636.7 7643.3 7711.2 7739.1 7742.7 7754.9 6876.7 6943.2 7001.5 7099.5 7142.7 6657.8 6821.4 6844.1 6969.4 7041.0 6437.5 6522.3 6542.9 6562.6 6578.6 4471.7 4509.5 4524.4 4607.4 4778.1 4584.0 4593.6 4639.4 4791.6 4803.1 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#4] prototype.html Cycles:180 Average:4704.24 Median:5373.33 stddev:1367.00 (25.4%) stddev-sans-first:1330.51 14:50:48 INFO - PROCESS | 25630 | Values: 312.8 318.9 320.6 321.9 322.3 5348.0 5417.6 5430.2 5460.6 5477.9 5336.5 5372.0 5382.4 5383.7 5388.4 3962.3 4087.3 4199.6 4212.6 4226.5 4225.0 4227.0 4238.6 4241.9 4245.6 4153.4 4185.4 4207.2 4217.1 4217.6 4061.5 4169.5 4203.7 4206.3 4208.4 3661.6 3682.2 3683.0 3683.2 3697.3 5152.5 5163.4 5172.3 5201.3 5235.3 4727.5 4809.3 4853.7 4855.8 4865.1 5672.1 5701.2 5709.4 5720.7 5727.3 4021.9 4056.2 4067.5 4069.6 4073.1 5702.6 5944.2 5962.7 5975.5 6001.6 4098.9 4118.0 4131.8 4144.1 4149.7 4202.8 4217.4 4222.6 4224.8 4231.2 4643.4 4735.3 4763.5 4786.3 4796.7 5605.4 5657.2 5670.6 5671.0 5707.1 1458.1 1466.4 1479.0 1484.6 1490.5 915.4 982.7 982.8 1004.6 1024.0 4821.2 4856.9 4904.4 4910.6 4932.5 5824.9 5827.7 5832.9 5848.7 5866.7 4816.4 4877.5 4888.9 4907.2 4915.0 3105.5 3110.1 3117.8 3134.9 3155.8 5447.4 5473.4 5482.1 5492.5 5512.8 5806.2 5986.7 5990.8 6025.5 6029.6 5437.4 5471.2 5493.7 5495.9 5512.9 5662.9 5850.9 5854.0 5866.1 5883.8 5707.9 5712.8 5713.3 5732.5 5738.8 5479.8 5490.6 5507.4 5517.3 5527.6 4069.5 4140.2 4167.5 4181.7 4208.3 5771.2 5774.7 5791.9 5792.4 5834.6 5624.8 5635.5 5635.9 5639.0 5641.7 5374.7 5758.3 5764.2 5772.4 5774.0 5301.7 5623.9 5663.6 5675.9 5676.3 5538.8 5706.1 5719.9 5728.7 5745.9 5596.9 5636.4 5668.9 5672.8 5691.2 14:50:48 INFO - PROCESS | 25630 | 14:50:48 INFO - PROCESS | 25630 | [#5] yui.html Cycles:180 Average:12657.19 Median:40971.49 stddev:14349.16 (35.0%) stddev-sans-first:14361.29 14:50:48 INFO - PROCESS | 25630 | Values: 693.8 738.9 746.7 767.5 773.8 11316.0 11442.4 11469.5 11523.7 11603.7 11842.3 11886.2 11983.4 12201.8 12225.4 622.5 788.2 795.3 807.2 807.3 815.2 815.4 817.2 817.4 819.0 860.9 862.2 862.3 862.9 865.0 853.0 854.5 854.5 855.5 858.0 617.3 618.7 619.2 619.8 625.6 11995.3 12056.3 12058.6 12078.0 12093.1 12848.3 13079.9 13121.5 13298.1 13326.3 10077.8 10292.7 10327.4 10506.5 10688.9 3360.4 3375.5 3398.4 3405.1 3490.9 47964.0 47984.8 48281.3 48594.8 50427.0 10264.4 10311.7 10435.8 10439.7 10483.2 17515.4 17697.7 17734.6 17777.5 17804.2 6911.8 6968.4 7002.3 7093.8 7108.0 3813.2 3865.8 3882.6 3897.7 3925.4 2673.1 2749.9 2758.7 2802.0 2805.7 495.5 495.6 498.1 503.9 505.3 468.4 572.2 577.0 605.9 622.7 7916.4 8068.5 8195.4 8270.0 8369.4 610.2 629.4 636.0 647.5 651.6 3776.9 3835.5 3871.4 3900.6 3919.4 51252.7 53304.7 53344.5 53384.0 53484.7 45132.0 46005.8 46321.5 46496.3 46526.5 39133.4 40920.0 41023.0 41077.6 42034.6 7436.4 7657.2 7762.3 7864.1 7910.4 25208.7 26966.0 27263.2 27818.2 27947.7 33627.8 35963.6 36672.6 37090.3 37313.0 10660.9 10757.6 10845.3 10900.6 10959.3 11578.9 11604.7 11617.5 11683.3 11964.2 10812.9 10889.8 11040.1 11149.1 11374.5 10941.1 11000.7 11014.9 11023.4 11347.1 9487.3 10573.8 10767.9 10806.4 10870.8 8967.6 9069.1 9073.5 9167.7 9341.3 8958.7 9297.1 9443.1 9484.6 9570.0 14:50:48 INFO - PROCESS | 25630 | -------- Summary: end -------- 14:50:48 INFO - PROCESS | 25630 | 14:50:49 INFO - TEST-INFO | 25630: exit 0 14:50:49 INFO - TEST-OK | dromaeo_css | took 1114241ms 14:50:49 INFO - TEST-START | kraken 14:50:49 INFO - operating with platform_type : linux_ 14:50:49 INFO - Initialising browser for kraken test... 14:50:49 INFO - TEST-INFO | started process 25864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2PLqqu/profile http://localhost:41777/getInfo.html) 14:50:52 INFO - PROCESS | 25864 | 14:50:52 INFO - PROCESS | 25864 | (process:25931): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:50:53 INFO - PROCESS | 25864 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 14:50:53 INFO - PROCESS | 25864 | __metrics Screen width/height:1600/1200 14:50:53 INFO - PROCESS | 25864 | colorDepth:24 14:50:53 INFO - PROCESS | 25864 | Browser inner width/height: 1024/697 14:50:53 INFO - PROCESS | 25864 | __metrics 14:50:54 ERROR - PROCESS | 25864 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 14:50:55 INFO - TEST-INFO | 25864: exit 0 14:50:55 INFO - Browser initialized. 14:50:55 INFO - Running cycle 1/1 for kraken test... 14:50:55 INFO - TEST-INFO | started process 25982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2PLqqu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:57 INFO - PROCESS | 25982 | 14:50:57 INFO - PROCESS | 25982 | (process:26040): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:51:07 INFO - PROCESS | 25982 | RSS: Main: 164909056 14:51:07 INFO - PROCESS | 25982 | 14:51:09 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41777/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:10 INFO - PROCESS | 25982 | RSS: Main: 169541632 14:51:10 INFO - PROCESS | 25982 | 14:51:13 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41777/tests/kraken/driver.html?testName=audio-dft) 14:51:14 INFO - PROCESS | 25982 | RSS: Main: 172580864 14:51:14 INFO - PROCESS | 25982 | 14:51:17 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41777/tests/kraken/driver.html?testName=audio-fft) 14:51:17 INFO - PROCESS | 25982 | RSS: Main: 165052416 14:51:17 INFO - PROCESS | 25982 | 14:51:19 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41777/tests/kraken/driver.html?testName=audio-oscillator) 14:51:20 INFO - PROCESS | 25982 | RSS: Main: 164352000 14:51:20 INFO - PROCESS | 25982 | 14:51:22 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:23 INFO - PROCESS | 25982 | RSS: Main: 164642816 14:51:23 INFO - PROCESS | 25982 | 14:51:26 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41777/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:27 INFO - PROCESS | 25982 | RSS: Main: 165498880 14:51:27 INFO - PROCESS | 25982 | 14:51:30 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41777/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:31 INFO - PROCESS | 25982 | RSS: Main: 164708352 14:51:31 INFO - PROCESS | 25982 | 14:51:34 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41777/tests/kraken/driver.html?testName=json-parse-financial) 14:51:34 INFO - PROCESS | 25982 | RSS: Main: 165146624 14:51:34 INFO - PROCESS | 25982 | 14:51:36 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:51:37 INFO - PROCESS | 25982 | RSS: Main: 165289984 14:51:37 INFO - PROCESS | 25982 | 14:51:39 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:51:39 INFO - PROCESS | 25982 | RSS: Main: 165171200 14:51:39 INFO - PROCESS | 25982 | 14:51:41 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:51:42 INFO - PROCESS | 25982 | RSS: Main: 165437440 14:51:42 INFO - PROCESS | 25982 | 14:51:45 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:51:46 INFO - PROCESS | 25982 | RSS: Main: 166371328 14:51:46 INFO - PROCESS | 25982 | 14:51:49 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:51:49 INFO - PROCESS | 25982 | RSS: Main: 166260736 14:51:49 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | Cycle 1(1): loaded http://localhost:41777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41777/tests/kraken/driver.html?testName=ai-astar) 14:51:51 INFO - PROCESS | 25982 | RSS: Main: 167313408 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | __start_tp_report 14:51:51 INFO - PROCESS | 25982 | _x_x_mozilla_page_load 14:51:51 INFO - PROCESS | 25982 | _x_x_mozilla_page_load_details 14:51:51 INFO - PROCESS | 25982 | |i|pagename|runs| 14:51:51 INFO - PROCESS | 25982 | |0;ai-astar;115;108;114;114;114;125;114;115;113;114 14:51:51 INFO - PROCESS | 25982 | |1;audio-beat-detection;163;137;161;199;141;157;162;132;188;133 14:51:51 INFO - PROCESS | 25982 | |2;audio-dft;167;163;166;164;170;162;164;163;167;162 14:51:51 INFO - PROCESS | 25982 | |3;audio-fft;76;74;75;156;75;74;74;74;153;74 14:51:51 INFO - PROCESS | 25982 | |4;audio-oscillator;93;95;147;94;94;95;142;94;93;145 14:51:51 INFO - PROCESS | 25982 | |5;imaging-gaussian-blur;118;117;117;118;117;118;118;118;118;122 14:51:51 INFO - PROCESS | 25982 | |6;imaging-darkroom;148;147;148;146;149;147;147;148;147;147 14:51:51 INFO - PROCESS | 25982 | |7;imaging-desaturate;95;96;97;96;94;95;96;96;96;95 14:51:51 INFO - PROCESS | 25982 | |8;json-parse-financial;67;68;67;67;68;67;68;84;66;71 14:51:51 INFO - PROCESS | 25982 | |9;json-stringify-tinderbox;64;65;64;65;64;66;64;65;63;64 14:51:51 INFO - PROCESS | 25982 | |10;stanford-crypto-aes;80;79;79;79;88;81;80;80;89;81 14:51:51 INFO - PROCESS | 25982 | |11;stanford-crypto-ccm;135;137;138;136;147;134;142;142;183;133 14:51:51 INFO - PROCESS | 25982 | |12;stanford-crypto-pbkdf2;178;175;180;189;180;189;184;177;172;186 14:51:51 INFO - PROCESS | 25982 | |13;stanford-crypto-sha256-iterative;74;74;75;74;75;76;75;78;74;76 14:51:51 INFO - PROCESS | 25982 | __end_tp_report 14:51:51 INFO - PROCESS | 25982 | __start_cc_report 14:51:51 INFO - PROCESS | 25982 | _x_x_mozilla_cycle_collect,926 14:51:51 INFO - PROCESS | 25982 | __end_cc_report 14:51:51 INFO - PROCESS | 25982 | __startTimestamp1460757111827__endTimestamp 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | ------- Summary: start ------- 14:51:51 INFO - PROCESS | 25982 | Number of tests: 14 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:4.17 (3.7%) stddev-sans-first:4.42 14:51:51 INFO - PROCESS | 25982 | Values: 115.0 108.0 114.0 114.0 114.0 125.0 114.0 115.0 113.0 114.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:161.50 stddev:22.75 (14.1%) stddev-sans-first:24.04 14:51:51 INFO - PROCESS | 25982 | Values: 163.0 137.0 161.0 199.0 141.0 157.0 162.0 132.0 188.0 133.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:2.62 (1.6%) stddev-sans-first:2.65 14:51:51 INFO - PROCESS | 25982 | Values: 167.0 163.0 166.0 164.0 170.0 162.0 164.0 163.0 167.0 162.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#3] audio-fft Cycles:10 Average:90.50 Median:74.00 stddev:33.74 (45.6%) stddev-sans-first:35.38 14:51:51 INFO - PROCESS | 25982 | Values: 76.0 74.0 75.0 156.0 75.0 74.0 74.0 74.0 153.0 74.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:94.00 stddev:24.51 (26.1%) stddev-sans-first:25.29 14:51:51 INFO - PROCESS | 25982 | Values: 93.0 95.0 147.0 94.0 94.0 95.0 142.0 94.0 93.0 145.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.45 (1.2%) stddev-sans-first:1.54 14:51:51 INFO - PROCESS | 25982 | Values: 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 122.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 14:51:51 INFO - PROCESS | 25982 | Values: 148.0 147.0 148.0 146.0 149.0 147.0 147.0 148.0 147.0 147.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 14:51:51 INFO - PROCESS | 25982 | Values: 95.0 96.0 97.0 96.0 94.0 95.0 96.0 96.0 96.0 95.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:68.00 stddev:5.33 (7.8%) stddev-sans-first:5.59 14:51:51 INFO - PROCESS | 25982 | Values: 67.0 68.0 67.0 67.0 68.0 67.0 68.0 84.0 66.0 71.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:51:51 INFO - PROCESS | 25982 | Values: 64.0 65.0 64.0 65.0 64.0 66.0 64.0 65.0 63.0 64.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:3.72 (4.6%) stddev-sans-first:3.90 14:51:51 INFO - PROCESS | 25982 | Values: 80.0 79.0 79.0 79.0 88.0 81.0 80.0 80.0 89.0 81.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:140.00 stddev:14.80 (10.6%) stddev-sans-first:15.44 14:51:51 INFO - PROCESS | 25982 | Values: 135.0 137.0 138.0 136.0 147.0 134.0 142.0 142.0 183.0 133.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:182.00 stddev:5.83 (3.2%) stddev-sans-first:6.08 14:51:51 INFO - PROCESS | 25982 | Values: 178.0 175.0 180.0 189.0 180.0 189.0 184.0 177.0 172.0 186.0 14:51:51 INFO - PROCESS | 25982 | 14:51:51 INFO - PROCESS | 25982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.00 stddev:1.29 (1.7%) stddev-sans-first:1.30 14:51:51 INFO - PROCESS | 25982 | Values: 74.0 74.0 75.0 74.0 75.0 76.0 75.0 78.0 74.0 76.0 14:51:51 INFO - PROCESS | 25982 | -------- Summary: end -------- 14:51:51 INFO - PROCESS | 25982 | 14:51:52 INFO - TEST-INFO | 25982: exit 0 14:51:52 INFO - TEST-OK | kraken | took 63775ms 14:51:52 INFO - SUITE-END | took 1178s 14:51:52 INFO - Completed test suite (00:19:38) 14:51:52 INFO - javascript benchmark 14:51:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.587426011838, 2625.737426257376, 2633.7234590368016, 2662.0283596487275, 2670.2923725212822, 4589.7016693914875, 4639.002614437895, 4653.8603841884715, 4692.953070469294, 4731.621470282378, 4535.092981403716, 4674.55591718787, 4708.552687494683, 4754.215554433515, 4787.952120478794, 4299.46256717911, 4406.317020861756, 4409.184300904343, 4417.514073451934, 4420.248557745175, 522.0726109836348, 4191.245575796355, 4215.620594146526, 4240.265299495187, 4262.147570485899, 4361.890952726176, 4363.956360436387, 4372.1255748850035, 4387.166438376714, 4393.802278897458, 4328.913421731548, 4369.213541562517, 4377.715448495869, 4379.4525684289465, 4413.3159360299205, 4271.700980931336, 4326.935095973563, 4330.285502892019, 4358.6730995175485, 4381.036172042146, 4575.885602859955, 4597.977010114928, 4600.332951722015, 4600.493945665974, 4626.537346265381, 4707.811687532495, 4889.3888263967, 5012.949870501321, 5029.547340739351, 5042.647014708972, 5007.223880298559, 5041.697498150123, 5042.39491261051, 5071.898562028776, 5089.923651145199, 4648.744319062416, 4649.1863923813535, 4694.718316900997, 4699.718016918996, 4736.550027747393, 4978.4025916890205, 5171.896562068738, 5193.922091168635, 5213.400458947193, 5290.761915713802, 4953.108440480748, 4975.203967365276, 4975.577075948512, 4976.502349765067, 4999.825006124768, 5034.697918124924, 5036.219385995177, 5045.091883461012, 5053.191489361684, 5067.011932673094, 4803.519648035169, 4949.950500495021, 4984.825531106394, 5022.723750193774, 5029.874253143627, 4860.465348811628, 4900.264960255919, 4924.015196960622, 4927.334809800703, 4985.8005679772405, 4196.412502249687, 4207.97896010518, 4210.705250632487, 4213.810378532973, 4242.17277630859, 3577.928441431157, 3581.28374325136, 3609.151849315409, 3697.759645623026, 3732.925341493209, 4272.957270427318, 4289.099289149313, 4296.226679197712, 4326.307790753464, 4334.414853994734, 5060.342155519759, 5080.390353157571, 5086.796528138833, 5097.337346144977, 5138.023775482647, 4193.832246710159, 4253.8723838284905, 4263.062126332202, 4268.722533035343, 4378.934315985262, 4480.977595112004, 4509.594136527729, 4526.02690421561, 4553.043860789205, 4576.130535198302, 4714.905701886011, 4715.481297057389, 4722.905541889074, 4725.07860967115, 4753.928691069567, 4847.345608342828, 5003.524665156804, 5005.899882002413, 5064.240363945438, 5075.0357432087785, 4771.904561908673, 4784.497627749175, 4786.922942337947, 4800.567948884617, 4836.250381190921, 4933.013397320622, 4983.152864013199, 4983.476734942778, 4992.950070499249, 5040.243963405372, 4822.204336284473, 5042.117629414911, 5043.646944713982, 5093.796248150033, 5118.411382691038, 4815.518448155297, 4841.564259216688, 4856.320115183948, 4880.292357608056, 4901.803927842846, 4868.245421959602, 4877.926831097608, 4880.682755620874, 4888.242322439885, 4948.6535942485125, 4585.541445855388, 4808.711477311373, 4818.10864989978, 4871.48849370811, 4872.658913875995, 4900.799304170501, 4918.163912134874, 4943.65394422387, 4951.554360107608, 4981.651284410056, 4838.927416088832, 4840.0, 4843.564079232886, 4844.46710861812, 4897.706137631753], "value": 4576.550591080747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9222504961829, 606.0636316890403, 610.3560743415698, 622.6139793328135, 634.844463106539, 33064.83467582665, 33893.0, 33980.66019339806, 33984.490232646465, 33984.66015339846, 34600.1349966251, 35419.0, 35498.46752298718, 35501.644983550155, 35515.0, 7407.814804629887, 7522.887156692654, 7533.0, 7551.829466432711, 7567.697292108309, 7376.041114655088, 7578.431617628672, 7641.4268929830205, 7646.120696119961, 7653.617319134049, 7651.885221721679, 7681.078270607535, 7690.5770182639935, 7702.0757509098985, 7719.228077192264, 7587.962060189691, 7599.012128423297, 7612.0, 7618.085829700443, 7632.389408847279, 7595.050618672666, 7695.461317707763, 7696.7306144284685, 7697.268759467842, 7701.653425595861, 29211.269718257, 34134.14664633379, 34400.0, 34691.826540867136, 34722.13194670128, 3053.0993356959752, 3128.671489493593, 3157.5579418881375, 3205.4390481665614, 3285.7042866141924, 24004.15985440501, 24215.87892060546, 24245.636315455282, 24885.62671559928, 25153.24540263795, 2727.4954133485367, 2758.462099890522, 2789.2190186747744, 2804.354998350391, 2871.9804469413475, 151908.0, 152485.0, 152545.0, 153511.23244383818, 183835.99999999866, 31570.526442103386, 31608.0, 31801.52297715536, 32371.19072023218, 33336.33327333488, 31367.68632313693, 31530.369392612018, 31641.050768476984, 31751.68248317487, 31763.52354714681, 12715.491380344683, 12889.742205155844, 12903.870961290455, 12910.548130815376, 12976.610701678965, 9525.095115963972, 9599.856002159973, 9608.423494590346, 9655.372400793925, 9685.370450920667, 8131.105578386373, 8158.0, 8164.224398682116, 8194.0, 8238.217369349903, 3178.936421271562, 3202.119417160253, 3207.486802111651, 3219.323941972212, 3224.5324427958285, 941.0730430525927, 941.4116177389132, 944.9622015119318, 987.2554299048657, 987.8814542254831, 27009.459810803673, 27964.0, 28088.29779255535, 28119.156425307272, 28643.713562864104, 1034.1933292032227, 1069.6790962711154, 1075.8816530181673, 1077.9299345542515, 1135.6990397544657, 14495.565133046026, 14994.400223991137, 15039.323230454656, 15090.849091508944, 15158.848411515964, 345095.0, 348028.0, 351847.0, 352374.0, 353454.0, 47978.28032579514, 48610.27084593734, 48625.75687121542, 48755.0, 48906.26640600394, 1232.8890399864056, 1268.4355461819587, 1277.6933535951491, 1279.539365828301, 1282.4165004922552, 26354.0, 27242.45515089727, 27445.176644700692, 27540.330611432466, 27874.0, 43119.78440107779, 43857.78071109624, 43919.0, 43932.0, 44100.55899440964, 309175.0, 315518.0, 316099.0, 316777.0, 319571.0, 25350.069790430225, 25458.0, 25689.100881469807, 25744.61383079218, 25808.612870806577, 40503.79748101241, 41102.79448602738, 41135.1772964545, 41733.791331043154, 41983.0, 36268.917142043225, 36703.265934681694, 36799.816000919825, 37029.81485092557, 37494.250114998096, 35438.64561354354, 35726.28547429089, 35983.64016359803, 36238.275234494635, 36295.818520907225, 31953.840230798698, 35216.64783352134, 35752.463713043806, 35965.28069438649, 36526.634733652325, 27304.180874573794, 29239.561406579345, 29864.552031719108, 29976.0, 31404.214894627818, 24326.51346973015, 24357.51284974255, 24794.380140496633, 25055.87472062701, 25304.493910122063], "value": 15601.245818747951, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.711053154868, 382.8774792066539, 385.76468354303876, 394.84601005607817, 402.4506548561215, 15289.464868729598, 16562.66874662509, 17139.400120995768, 17234.482965511055, 17405.129743512807, 15406.152661603608, 15545.53363399097, 15706.528804135865, 15757.369705211806, 15813.60465988348, 5108.69347839129, 5263.86840328991, 5271.235670827747, 5285.233641122035, 5305.602079844027, 3702.962970370302, 5772.163036359725, 6077.696115194245, 6079.088136779496, 6135.9079613805825, 4998.425181104165, 6009.699515024253, 6014.669193194372, 6015.669138197398, 6070.696465176746, 5228.738563071869, 5232.947670523303, 5251.002309561171, 5256.526912577867, 5273.182656688219, 4988.603191106496, 5392.946070539284, 5461.290032295816, 5461.918071228934, 5469.179623056573, 11970.82043769344, 12453.315067671274, 12631.621051368382, 12645.557405490763, 12731.490740370375, 1941.5148609779505, 1993.157816450995, 2160.8487405881597, 2172.196287373666, 2349.929502114939, 9214.723558293195, 9292.210162136227, 9643.421394716339, 11754.29474231549, 12513.499460021589, 1824.9908750456163, 1873.9156737946826, 1884.7361369408293, 1903.961920761577, 1920.9626801527158, 66140.6692966537, 69090.61818763596, 69592.65203674, 69643.65178174127, 70031.2996870035, 9928.0, 9960.505924111441, 10169.830369548597, 10280.485975701185, 10414.323069000491, 14465.13209207451, 14562.635934101732, 14566.854331456761, 14588.416463341347, 14593.92703036478, 6921.792346229621, 7018.859622807515, 7097.432205423554, 7101.467389945775, 7148.0, 6356.523260755369, 6388.39310265524, 6396.5202609804455, 6501.544891857525, 6534.509911756637, 4391.275439552502, 4411.2721400968485, 4462.665300102505, 4500.167469018242, 4505.256632655641, 1693.4073074423852, 1836.0701516428433, 1916.4633902507321, 1927.0557426861017, 1927.8554108441922, 944.8236945003515, 953.1850268020743, 971.7813491964392, 981.5141504954951, 1005.331454582709, 16531.090790006423, 16762.58093547671, 16808.159592020595, 16830.0, 17043.65912681764, 836.4855613797471, 869.5608717597572, 882.4264228251687, 972.2805124208035, 978.7699890525721, 8797.296216302808, 9153.908460915438, 9163.95418022919, 9189.981454523679, 9252.491112988715, 441624.0, 444409.0, 446333.0, 450157.0, 456526.0, 68835.3116468829, 72342.0, 78772.60613697009, 82399.17600824035, 82893.58553207196, 973.3089506450358, 975.970351279407, 1016.3444578246989, 1048.9423081730426, 1060.8143574874366, 14829.925850370679, 15078.472253471076, 15181.392744290104, 15323.157226352658, 16073.35706571724, 34150.82924585361, 34274.0, 34738.478922816685, 35234.647653523134, 35542.46686299759, 49286.01427971349, 49363.012739744285, 49928.75035624798, 49980.0, 50638.0, 7665.3101220890385, 7818.313121000166, 7906.644201011083, 7930.405219608437, 8007.679692812222, 8728.476291422536, 10836.945815271189, 11476.540938362372, 11499.367534785668, 11650.88349116498, 9772.364796288219, 9864.901350986398, 10103.848442273225, 10327.948360258151, 10444.903285155253, 9454.440017397328, 10261.486925653837, 10531.210159237935, 10557.15542756593, 10738.516766745672, 9758.316917815968, 10026.69919902404, 10500.894991050298, 10750.354978701303, 10760.300580462244, 6695.196576410862, 7098.254683258184, 7840.0199975003125, 7849.921500784919, 7853.685852565834, 9761.121499065119, 10464.162866970471, 10698.73253168677, 10785.838212426977, 10900.182486313399], "value": 8226.81162224416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.0672866001426, 1480.8000919875815, 1598.888077834552, 1755.3943889358175, 1758.7977382600989, 6825.6928438220275, 7725.497842640231, 7884.763457096282, 7980.9201907980905, 8015.278624923763, 7861.056673199224, 7911.802204944879, 7936.722214722486, 7946.443748937577, 7960.08459027212, 2228.999999999996, 2238.3620668109593, 2252.054137262354, 2257.0858802185057, 2259.164109279569, 2213.380253529014, 2267.501149747053, 2277.0095008671283, 2277.6925115109416, 2299.1952816514254, 2271.1483193802324, 2289.301762962296, 2293.2776175504746, 2303.3090072978125, 2306.1928325086255, 2217.4013016485537, 2218.3234113595345, 2222.688823564702, 2228.3649159989327, 2230.8549944253655, 2230.375494861425, 2248.3592176229695, 2256.345659758668, 2260.412292803883, 2268.3421807675754, 8055.798605034863, 8068.0, 8077.555734434603, 8107.22981316774, 8142.674293028272, 4713.835015774465, 4842.66101372904, 4849.636277279218, 4879.560839524424, 4887.975560122212, 2882.9711702882914, 2975.717306855867, 3015.3064795097252, 3018.607581014454, 3032.150997720642, 1608.6139326561658, 1674.7655328254054, 1693.9068351240676, 1712.6403455274408, 1721.4233231867215, 10892.292001019909, 11021.724456888562, 11088.112950963903, 11106.777864442665, 11134.554617815278, 4217.304144816071, 4224.577542245751, 4308.633766129914, 4324.632406245504, 4351.5430879757805, 8770.298376129895, 8791.296696264284, 8852.159044890725, 8856.911430885737, 8865.335099867536, 4695.741734204652, 4699.389079419653, 4708.176069187878, 4709.646776491777, 4719.669623126349, 3780.111673756665, 4215.494140703136, 4297.5702429756775, 4298.849540266076, 4353.69524133314, 3534.3991521441417, 3581.8209089545417, 3636.1636823530735, 3642.5446819147605, 3722.8324725387424, 1094.8631421072366, 1097.1661537231762, 1105.0883021507289, 1109.051760744568, 1109.1404161774528, 734.9265073492608, 863.1627321498137, 874.4403581707712, 890.1143362354499, 891.5542228885557, 5218.399884013387, 5263.157894736823, 5331.360236771612, 5396.703181324986, 5490.478404551562, 412.69460599156406, 416.9249535083653, 427.5553424438549, 433.10347580508676, 436.91698577270216, 3634.2731453708834, 3725.590185079639, 3737.5328083989502, 3741.8690345837763, 3799.886003419902, 9761.219102471927, 10062.345947513388, 10208.234382421348, 10208.948955255177, 10239.539220734936, 9988.700338989842, 9994.350367226107, 10051.346662466916, 10053.497325133714, 10112.191024718006, 6889.069975553336, 7335.7432489862595, 7373.33639972405, 7398.0012698285045, 7442.516236444614, 5367.248585197997, 5368.570514358764, 5526.696031718294, 5548.500634942875, 5605.0, 8987.55062246872, 9004.054574269869, 9118.544072796467, 9142.405743626643, 9196.632134714537, 8857.0, 9070.773230669287, 9257.120573545502, 9345.953270233877, 9388.530573471437, 6884.242733299233, 7411.107170863229, 7610.12483564375, 7629.54222746637, 7636.656350464354, 7643.312101910855, 7711.151773305044, 7739.148693643582, 7742.729004484816, 7754.92245077542, 6876.69054892541, 6943.236244013054, 7001.544899581511, 7099.503034787515, 7142.678579463833, 6657.800265992028, 6821.420179284618, 6844.110265665432, 6969.442444604318, 7041.049458323061, 6437.452816510462, 6522.287948914797, 6542.934570654233, 6562.639054851838, 6578.572392794453, 4471.709338892962, 4509.50395456493, 4524.41182646267, 4607.378003969421, 4778.068276686013, 4583.991521865184, 4593.586577208067, 4639.396878405786, 4791.5687588117235, 4803.1354356214815], "value": 4229.046527626192, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.7794904592263, 318.86288895774805, 320.5960489782873, 321.94205043092234, 322.2716660347615, 5347.9783922084, 5417.566594672427, 5430.15832545955, 5460.563154947609, 5477.945220547794, 5336.546393556552, 5371.973140134303, 5382.354117505895, 5383.650062745928, 5388.407275199725, 3962.286788378091, 4087.305158123126, 4199.55904630014, 4212.641925436342, 4226.492820861501, 4224.97887510562, 4227.0, 4238.554951730071, 4241.87274381769, 4245.554216807222, 4153.397757325186, 4185.434966279559, 4207.200631879949, 4217.072244106292, 4217.599328063844, 4061.4720086388875, 4169.519820463722, 4203.663706903471, 4206.326987681956, 4208.389783481393, 3661.5972243053243, 3682.226732386175, 3682.987178525927, 3683.1528748387755, 3697.2975134724315, 5152.531528514392, 5163.406208286057, 5172.250023746536, 5201.349831271091, 5235.293235413209, 4727.463574338354, 4809.302651115604, 4853.708777473363, 4855.781489832966, 4865.124277630025, 5672.12082127271, 5701.230333904953, 5709.371969083398, 5720.742566584514, 5727.255456790591, 4021.8994525136814, 4056.2090392373498, 4067.5118985721606, 4069.552349241581, 4073.103917138225, 5702.600817942745, 5944.167816505649, 5962.736643300062, 5975.492083172936, 6001.639901605874, 4098.918021639551, 4117.958820411757, 4131.752094874317, 4144.052295421147, 4149.738392575993, 4202.831886724558, 4217.36739489073, 4222.619964203175, 4224.8098835551855, 4231.19607274623, 4643.396358473445, 4735.289706544046, 4763.54746299101, 4786.2581299898575, 4796.712197268175, 5605.383407825136, 5657.236273103161, 5670.631408958405, 5670.971645141748, 5707.143928410772, 1458.0741229319458, 1466.3914475492763, 1478.9556313310618, 1484.6362641152987, 1490.4857824050684, 915.4278575890069, 982.7248370456284, 982.7690492734201, 1004.6082028009082, 1024.0, 4821.228603423436, 4856.902861942812, 4904.386951631046, 4910.582600479, 4932.482089380564, 5824.854378640568, 5827.708614569339, 5832.88334233313, 5848.707564621752, 5866.67733274674, 4816.373871396766, 4877.463479017305, 4888.902221955541, 4907.214845624683, 4914.950850491521, 3105.509355509368, 3110.0980715592677, 3117.828519431453, 3134.9373012539622, 3155.763317751178, 5447.420248128078, 5473.425290344536, 5482.068048431776, 5492.505674489315, 5512.834614961557, 5806.2451881255165, 5986.700664966735, 5990.820275391745, 6025.4577088061405, 6029.638221706624, 5437.39005277469, 5471.179323101487, 5493.670379777226, 5495.945040549544, 5512.889742205133, 5662.858428539154, 5850.912236316543, 5853.970730146322, 5866.090755932837, 5883.764649413975, 5707.886962042528, 5712.7714891403875, 5713.257276554022, 5732.5031730645105, 5738.799142030009, 5479.821838304624, 5490.6431081979545, 5507.449255074461, 5517.337919449692, 5527.640703354269, 4069.5320038195987, 4140.171965606831, 4167.4790651168605, 4181.665466762713, 4208.263553878121, 5771.192033115283, 5774.682392468455, 5791.901332786939, 5792.4497172768515, 5834.649921004753, 5624.775008999594, 5635.492805647511, 5635.88728225425, 5639.0, 5641.717914104361, 5374.677519348852, 5758.280214973129, 5764.164196191445, 5772.39389864075, 5773.9895518284975, 5301.701083234632, 5623.943760562342, 5663.631863928997, 5675.943240567542, 5676.262085928803, 5538.833834984957, 5706.144078388109, 5719.942800571941, 5728.742206600797, 5745.942540574708, 5596.86007849807, 5636.436356364331, 5668.914966275427, 5672.787612831082, 5691.174779657009], "value": 4267.573883016409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.82574720653, 738.944579156563, 746.7199800074972, 767.5394763142116, 773.8026803165192, 11316.0, 11442.427878606057, 11469.541218351256, 11523.711907202323, 11603.709907252323, 11842.348670823101, 11886.227395219305, 11983.40082995849, 12201.75596488072, 12225.449854756534, 622.5299898576591, 788.1802924958037, 795.296162895837, 807.2169995104739, 807.2855522862251, 815.1725998111921, 815.3966065111833, 817.15832692327, 817.3787921179917, 818.9877151842727, 860.8837806896051, 862.1981557151846, 862.3446180902528, 862.9395942284043, 864.9913500864974, 852.9616167272487, 854.5385491834402, 854.5428195915156, 855.5166331022983, 857.9871301930476, 617.3363634093367, 618.709206672863, 619.2476141488069, 619.7737825693634, 625.5964902637819, 11995.340256285901, 12056.276623402624, 12058.638240852788, 12078.0, 12093.093018023683, 12848.293343866084, 13079.86920130796, 13121.47514099435, 13298.135621184592, 13326.267055311953, 10077.848832267522, 10292.742681432948, 10327.380357178594, 10506.474676266156, 10688.893111068868, 3360.395128876801, 3375.5274261603395, 3398.4222682144095, 3405.0636075079306, 3490.89527314181, 47964.0, 47984.760076199396, 48281.27578086332, 48594.757026215, 50426.999999999636, 10264.435456049989, 10311.74220644475, 10435.791284174426, 10439.686809395731, 10483.213758968108, 17515.386961456286, 17697.734533982002, 17734.556636083944, 17777.46667599974, 17804.198811053535, 6911.75808846688, 6968.44252459802, 7002.299770023059, 7093.82265443368, 7108.040414543971, 3813.1992281620614, 3865.768053916774, 3882.592327805596, 3897.668698160688, 3925.371940489508, 2673.0777881630806, 2749.8900043998415, 2758.6965433802266, 2802.0, 2805.691373948864, 495.4896456649657, 495.55647695312496, 498.08601216766914, 503.85640092574175, 505.2774532418603, 468.39810843066493, 572.2446370790517, 576.9624974376652, 605.9424354686298, 622.6762083716442, 7916.406269529693, 8068.47554908929, 8195.42632015765, 8270.0, 8369.372297077743, 610.1518888744648, 629.4209327418786, 635.9841003974938, 647.5402464250341, 651.6220592056595, 3776.905577360533, 3835.463035175078, 3871.3612253977776, 3900.570937196906, 3919.412088186795, 51252.71868203325, 53304.733476333146, 53344.46655533473, 53384.0, 53484.73257633687, 45132.0, 46005.76997114993, 46321.536784631724, 46496.3025554617, 46526.53473465222, 39133.41299880504, 40919.97700057522, 41022.9999999994, 41077.589224107374, 42034.579654203066, 7436.442266830118, 7657.157712651492, 7762.340201082971, 7864.134945155914, 7910.406719496176, 25208.74791252064, 26966.0, 27263.182104536896, 27818.191817531795, 27947.720522794512, 33627.83186084054, 35963.64036359708, 36672.63327366692, 37090.25819483649, 37313.0, 10660.946695266473, 10757.623483178051, 10845.349279043283, 10900.618478353219, 10959.287646302964, 11578.94210528942, 11604.6518604442, 11617.47721352558, 11683.299002059903, 11964.222325548812, 10812.891871081189, 10889.782204356026, 11040.116790656888, 11149.108071354434, 11374.488148033524, 10941.12471002302, 11000.724981875517, 11014.889851101387, 11023.44882755875, 11347.14896382791, 9487.288453365887, 10573.788524229627, 10767.946160269148, 10806.405647689453, 10870.836937445787, 8967.641294348154, 9069.138431848964, 9073.45559266446, 9167.724968250963, 9341.252699783865, 8958.68644597436, 9297.116773906468, 9443.102905223992, 9484.620615175316, 9569.952150239204], "value": 5926.262777114724, "unit": "score"}], "name": "dromaeo_css", "value": 6305.1523152881955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 114.0, 114.0, 114.0, 125.0, 114.0, 115.0, 113.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 161.0, 199.0, 141.0, 157.0, 162.0, 132.0, 188.0, 133.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 166.0, 164.0, 170.0, 162.0, 164.0, 163.0, 167.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 156.0, 75.0, 74.0, 74.0, 74.0, 153.0, 74.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 147.0, 94.0, 94.0, 95.0, 142.0, 94.0, 93.0, 145.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 122.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 149.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 94.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 84.0, 66.0, 71.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 63.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 88.0, 81.0, 80.0, 80.0, 89.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 138.0, 136.0, 147.0, 134.0, 142.0, 142.0, 183.0, 133.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 175.0, 180.0, 189.0, 180.0, 189.0, 184.0, 177.0, 172.0, 186.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 74.0, 75.0, 76.0, 75.0, 78.0, 74.0, 76.0], "value": 75.1, "unit": "score"}], "name": "kraken", "value": 1611.6000000000001, "alertThreshold": 2.0}]} 14:51:53 INFO - Return code: 0 14:51:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:51:53 ERROR - # TBPL SUCCESS # 14:51:53 INFO - Running post-action listener: _resource_record_post_action 14:51:53 INFO - Running post-run listener: _resource_record_post_run 14:51:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 522792960; Read time: 0; Write time: 416600 14:51:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233439232; Read time: 0; Write time: 240144 14:51:54 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 283983872; Read time: 0; Write time: 162028 14:51:54 INFO - Running post-run listener: _upload_blobber_files 14:51:54 INFO - Blob upload gear active. 14:51:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:51:54 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 14:51:54 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:51:54 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:51:54 INFO - (blobuploader) - INFO - Open directory for files ... 14:51:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:51:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:51:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:55 INFO - (blobuploader) - INFO - Done attempting. 14:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:51:56 INFO - (blobuploader) - INFO - Done attempting. 14:51:56 INFO - (blobuploader) - INFO - Iteration through files over. 14:51:56 INFO - Return code: 0 14:51:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:51:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:51:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/182ea80dbe9bc79012cbd26c23aad262bc443a0157419b49a0cfa630f3ad2a7902ba0bd2be2348bd03473e22280ba111479224988ebc525d18823ed1e4d717fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abd3dd155d625a816388e995ac94508a287f73e87f106b558fe6f9a8b8b487e07d0418e8545f9994ac093a1503f1ff3ffa2928ab37c1fba3fd906bfc0808ffba"} 14:51:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:51:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:51:56 INFO - Contents: 14:51:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/182ea80dbe9bc79012cbd26c23aad262bc443a0157419b49a0cfa630f3ad2a7902ba0bd2be2348bd03473e22280ba111479224988ebc525d18823ed1e4d717fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abd3dd155d625a816388e995ac94508a287f73e87f106b558fe6f9a8b8b487e07d0418e8545f9994ac093a1503f1ff3ffa2928ab37c1fba3fd906bfc0808ffba"} 14:51:56 INFO - Running post-run listener: copy_logs_to_upload_dir 14:51:56 INFO - Copying logs to upload dir... 14:51:56 INFO - mkdir: /builds/slave/test/build/upload/logs 14:51:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.222802 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-15 14:51:54.991703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:51:54.995736) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 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-Non-PGO/sha512/182ea80dbe9bc79012cbd26c23aad262bc443a0157419b49a0cfa630f3ad2a7902ba0bd2be2348bd03473e22280ba111479224988ebc525d18823ed1e4d717fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abd3dd155d625a816388e995ac94508a287f73e87f106b558fe6f9a8b8b487e07d0418e8545f9994ac093a1503f1ff3ffa2928ab37c1fba3fd906bfc0808ffba"} build_url:https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/f0GqfiBMSnmGbRQ3OFDLoA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/182ea80dbe9bc79012cbd26c23aad262bc443a0157419b49a0cfa630f3ad2a7902ba0bd2be2348bd03473e22280ba111479224988ebc525d18823ed1e4d717fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/abd3dd155d625a816388e995ac94508a287f73e87f106b558fe6f9a8b8b487e07d0418e8545f9994ac093a1503f1ff3ffa2928ab37c1fba3fd906bfc0808ffba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 14:51:55.025293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:51:55.025633) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460751838.622746-1921102425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 14:51:55.111666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 14:51:55.111998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 14:51:55.112303) ========= ========= Total master_lag: 0.19 =========