builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1462830775.58 results: success (0) buildid: 20160509143200 builduid: 0222f7743f3141c9b25fd0b8d14344db revision: 335e95e6cdc528b60638b2a9802071f8143fe854 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.583978) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.584515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.584862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.594125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.594419) ========= 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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 14:52:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.9M=0s 2016-05-09 14:52:55 (65.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.721230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.721611) ========= 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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009685 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:55.768257) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 14:52:55.768636) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 335e95e6cdc528b60638b2a9802071f8143fe854 --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 335e95e6cdc528b60638b2a9802071f8143fe854 --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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 14:52:56,023 truncating revision to first 12 chars 2016-05-09 14:52:56,023 Setting DEBUG logging. 2016-05-09 14:52:56,023 attempt 1/10 2016-05-09 14:52:56,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/335e95e6cdc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 14:52:57,086 unpacking tar archive at: fx-team-335e95e6cdc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310354 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-09 14:52:57.087473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:57.087847) ========= script_repo_revision: 335e95e6cdc528b60638b2a9802071f8143fe854 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:57.088309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:57.088633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 14:52:57.094646) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-09 14:52:57.094949) ========= /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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:52:57 INFO - MultiFileLogger online at 20160509 14:52:57 in /builds/slave/test 14:52:57 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:52:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:52:57 INFO - {'append_to_log': False, 14:52:57 INFO - 'base_work_dir': '/builds/slave/test', 14:52:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:52:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:52:57 INFO - 'branch': 'Fx-Team-Non-PGO', 14:52:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:57 INFO - 'config_files': ('talos/linux_config.py',), 14:52:57 INFO - 'default_actions': ('clobber', 14:52:57 INFO - 'read-buildbot-config', 14:52:57 INFO - 'download-and-extract', 14:52:57 INFO - 'populate-webroot', 14:52:57 INFO - 'create-virtualenv', 14:52:57 INFO - 'install', 14:52:57 INFO - 'run-tests'), 14:52:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:57 INFO - 'download_minidump_stackwalk': True, 14:52:57 INFO - 'download_symbols': 'ondemand', 14:52:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:57 INFO - 'installer_path': 'installer.exe', 14:52:57 INFO - 'log_level': 'info', 14:52:57 INFO - 'log_name': 'talos', 14:52:57 INFO - 'log_to_console': True, 14:52:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:52:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:52:57 INFO - 'opt_config_files': (), 14:52:57 INFO - 'pip_index': False, 14:52:57 INFO - 'sps_profile': False, 14:52:57 INFO - 'sps_profile_interval': 0, 14:52:57 INFO - 'suite': 'dromaeojs-e10s', 14:52:57 INFO - 'system_bits': '32', 14:52:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:57 INFO - 'title': 'talos-linux64-ix-031', 14:52:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:57 INFO - 'use_talos_json': True, 14:52:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:52:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:57 INFO - 'work_dir': 'build'} 14:52:57 INFO - ##### 14:52:57 INFO - ##### Running clobber step. 14:52:57 INFO - ##### 14:52:57 INFO - Running pre-action listener: _resource_record_pre_action 14:52:57 INFO - Running main action method: clobber 14:52:57 INFO - rmtree: /builds/slave/test/build 14:52:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:57 INFO - Running post-action listener: _resource_record_post_action 14:52:57 INFO - ##### 14:52:57 INFO - ##### Finished clobber step (success) 14:52:57 INFO - ##### 14:52:57 INFO - ##### 14:52:57 INFO - ##### Running read-buildbot-config step. 14:52:57 INFO - ##### 14:52:57 INFO - Running pre-action listener: _resource_record_pre_action 14:52:57 INFO - Running main action method: read_buildbot_config 14:52:57 INFO - Using buildbot properties: 14:52:57 INFO - { 14:52:57 INFO - "project": "", 14:52:57 INFO - "product": "firefox", 14:52:57 INFO - "script_repo_revision": "production", 14:52:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:52:57 INFO - "repository": "", 14:52:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:52:57 INFO - "buildid": "20160509143200", 14:52:57 INFO - "pgo_build": "False", 14:52:57 INFO - "basedir": "/builds/slave/test", 14:52:57 INFO - "buildnumber": 1269, 14:52:57 INFO - "slavename": "talos-linux64-ix-031", 14:52:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:52:57 INFO - "platform": "ubuntu64_hw", 14:52:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:52:57 INFO - "branch": "fx-team", 14:52:57 INFO - "repo_path": "integration/fx-team", 14:52:57 INFO - "revision": "335e95e6cdc528b60638b2a9802071f8143fe854", 14:52:57 INFO - "stage_platform": "linux64", 14:52:57 INFO - "builduid": "0222f7743f3141c9b25fd0b8d14344db", 14:52:57 INFO - "slavebuilddir": "test" 14:52:57 INFO - } 14:52:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:52:57 INFO - Running post-action listener: _resource_record_post_action 14:52:57 INFO - ##### 14:52:57 INFO - ##### Finished read-buildbot-config step (success) 14:52:57 INFO - ##### 14:52:57 INFO - ##### 14:52:57 INFO - ##### Running download-and-extract step. 14:52:57 INFO - ##### 14:52:57 INFO - Running pre-action listener: _resource_record_pre_action 14:52:57 INFO - Running main action method: download_and_extract 14:52:57 INFO - mkdir: /builds/slave/test/build/tests 14:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:57 INFO - https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:52:58 INFO - Downloaded 1361 bytes. 14:52:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:52:58 INFO - Using the following test package requirements: 14:52:58 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:52:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:52:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'jsshell-linux-x86_64.zip'], 14:52:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:52:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:52:58 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:52:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:52:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:58 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:52:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:58 INFO - https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:52:59 INFO - Downloaded 22323319 bytes. 14:52:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:52:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:00 INFO - Return code: 0 14:53:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:00 INFO - https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:53:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:01 INFO - Downloaded 22323319 bytes. 14:53:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:03 INFO - Return code: 0 14:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:03 INFO - https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:53:03 INFO - Downloaded 10840152 bytes. 14:53:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:53:04 INFO - Return code: 0 14:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:04 INFO - https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:53:05 INFO - Downloaded 54859610 bytes. 14:53:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:05 INFO - mkdir: /builds/slave/test/properties 14:53:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:05 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:05 INFO - Contents: 14:53:05 INFO - build_url:https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:06 INFO - Running post-action listener: _resource_record_post_action 14:53:06 INFO - Running post-action listener: set_extra_try_arguments 14:53:06 INFO - ##### 14:53:06 INFO - ##### Finished download-and-extract step (success) 14:53:06 INFO - ##### 14:53:06 INFO - ##### 14:53:06 INFO - ##### Running populate-webroot step. 14:53:06 INFO - ##### 14:53:06 INFO - Running pre-action listener: _resource_record_pre_action 14:53:06 INFO - Running main action method: populate_webroot 14:53:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:06 INFO - '--tppagecycles', 14:53:06 INFO - '7'], 14:53:06 INFO - 'tests': ['tsvgm']}}, 14:53:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['damp', 'tps']}, 14:53:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'tests': ['damp', 'tps']}, 14:53:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['dromaeo_dom']}, 14:53:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['a11yr', 14:53:06 INFO - 'ts_paint', 14:53:06 INFO - 'tpaint', 14:53:06 INFO - 'sessionrestore', 14:53:06 INFO - 'sessionrestore_no_auto_restore', 14:53:06 INFO - 'tabpaint']}, 14:53:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['tsvgx', 14:53:06 INFO - 'tsvgr_opacity', 14:53:06 INFO - 'tart', 14:53:06 INFO - 'tscrollx', 14:53:06 INFO - 'cart']}, 14:53:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:06 INFO - 'tsvgr_opacity', 14:53:06 INFO - 'tart', 14:53:06 INFO - 'tscrollx', 14:53:06 INFO - 'cart']}, 14:53:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'talos_options': ['--disable-e10s'], 14:53:06 INFO - 'tests': ['tp5o']}, 14:53:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'tests': ['tp5o']}, 14:53:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'talos_options': ['--disable-e10s', 14:53:06 INFO - '--xperf_path', 14:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:06 INFO - 'tests': ['tp5n']}, 14:53:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:06 INFO - 'talos_options': ['--xperf_path', 14:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:06 INFO - 'tests': ['tp5n']}}, 14:53:06 INFO - 'talos.zip': {'path': '', 14:53:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:06 INFO - Running post-action listener: _resource_record_post_action 14:53:06 INFO - ##### 14:53:06 INFO - ##### Finished populate-webroot step (success) 14:53:06 INFO - ##### 14:53:06 INFO - ##### 14:53:06 INFO - ##### Running create-virtualenv step. 14:53:06 INFO - ##### 14:53:06 INFO - Running pre-action listener: _resource_record_pre_action 14:53:06 INFO - Running main action method: create_virtualenv 14:53:06 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:06 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:53:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:06 INFO - Using real prefix '/usr' 14:53:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:06 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:08 INFO - Installing pip.................done. 14:53:08 INFO - Return code: 0 14:53:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:08 INFO - Using env: {'DISPLAY': ':0', 14:53:08 INFO - 'HOME': '/home/cltbld', 14:53:08 INFO - 'LANG': 'en_US.UTF-8', 14:53:08 INFO - 'LANGUAGE': 'en_US:en', 14:53:08 INFO - 'LOGNAME': 'cltbld', 14:53:08 INFO - 'MAIL': '/var/mail/cltbld', 14:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:08 INFO - 'MOZ_NO_REMOTE': '1', 14:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:08 INFO - 'NO_EM_RESTART': '1', 14:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:08 INFO - 'PWD': '/builds/slave/test', 14:53:08 INFO - 'SHELL': '/bin/bash', 14:53:08 INFO - 'SHLVL': '1', 14:53:08 INFO - 'TERM': 'linux', 14:53:08 INFO - 'TMOUT': '86400', 14:53:08 INFO - 'USER': 'cltbld', 14:53:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:08 INFO - '_': '/tools/buildbot/bin/python'} 14:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:09 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:53:09 INFO - Cleaning up... 14:53:09 INFO - Return code: 0 14:53:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:53:09 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:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:09 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:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:09 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 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:09 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:53:09 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:53:09 INFO - Using env: {'DISPLAY': ':0', 14:53:09 INFO - 'HOME': '/home/cltbld', 14:53:09 INFO - 'LANG': 'en_US.UTF-8', 14:53:09 INFO - 'LANGUAGE': 'en_US:en', 14:53:09 INFO - 'LOGNAME': 'cltbld', 14:53:09 INFO - 'MAIL': '/var/mail/cltbld', 14:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:09 INFO - 'MOZ_NO_REMOTE': '1', 14:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:09 INFO - 'NO_EM_RESTART': '1', 14:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:09 INFO - 'PWD': '/builds/slave/test', 14:53:09 INFO - 'SHELL': '/bin/bash', 14:53:09 INFO - 'SHLVL': '1', 14:53:09 INFO - 'TERM': 'linux', 14:53:09 INFO - 'TMOUT': '86400', 14:53:09 INFO - 'USER': 'cltbld', 14:53:09 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:09 INFO - '_': '/tools/buildbot/bin/python'} 14:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:09 INFO - Downloading/unpacking psutil>=0.7.1 14:53:09 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:53:09 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:53:09 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:53:09 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:53:09 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:53:09 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:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:11 INFO - Installing collected packages: psutil 14:53:11 INFO - Running setup.py install for psutil 14:53:11 INFO - building 'psutil._psutil_linux' extension 14:53:11 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:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:53:11 INFO - building 'psutil._psutil_posix' extension 14:53:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:53:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:53:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:11 INFO - Successfully installed psutil 14:53:11 INFO - Cleaning up... 14:53:11 INFO - Return code: 0 14:53:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:53:11 INFO - Using env: {'DISPLAY': ':0', 14:53:11 INFO - 'HOME': '/home/cltbld', 14:53:11 INFO - 'LANG': 'en_US.UTF-8', 14:53:11 INFO - 'LANGUAGE': 'en_US:en', 14:53:11 INFO - 'LOGNAME': 'cltbld', 14:53:11 INFO - 'MAIL': '/var/mail/cltbld', 14:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:11 INFO - 'MOZ_NO_REMOTE': '1', 14:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:11 INFO - 'NO_EM_RESTART': '1', 14:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:11 INFO - 'PWD': '/builds/slave/test', 14:53:11 INFO - 'SHELL': '/bin/bash', 14:53:11 INFO - 'SHLVL': '1', 14:53:11 INFO - 'TERM': 'linux', 14:53:11 INFO - 'TMOUT': '86400', 14:53:11 INFO - 'USER': 'cltbld', 14:53:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:11 INFO - '_': '/tools/buildbot/bin/python'} 14:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:13 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:53:13 INFO - Installing collected packages: mozsystemmonitor 14:53:13 INFO - Running setup.py install for mozsystemmonitor 14:53:13 INFO - Successfully installed mozsystemmonitor 14:53:13 INFO - Cleaning up... 14:53:13 INFO - Return code: 0 14:53:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53: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:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:53:13 INFO - Using env: {'DISPLAY': ':0', 14:53:13 INFO - 'HOME': '/home/cltbld', 14:53:13 INFO - 'LANG': 'en_US.UTF-8', 14:53:13 INFO - 'LANGUAGE': 'en_US:en', 14:53:13 INFO - 'LOGNAME': 'cltbld', 14:53:13 INFO - 'MAIL': '/var/mail/cltbld', 14:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:13 INFO - 'MOZ_NO_REMOTE': '1', 14:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:13 INFO - 'NO_EM_RESTART': '1', 14:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:13 INFO - 'PWD': '/builds/slave/test', 14:53:13 INFO - 'SHELL': '/bin/bash', 14:53:13 INFO - 'SHLVL': '1', 14:53:13 INFO - 'TERM': 'linux', 14:53:13 INFO - 'TMOUT': '86400', 14:53:13 INFO - 'USER': 'cltbld', 14:53:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:13 INFO - '_': '/tools/buildbot/bin/python'} 14:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:53:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:53:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:53:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:16 INFO - Downloading docopt-0.6.1.tar.gz 14:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:53:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:53:16 INFO - Running setup.py install for blobuploader 14:53:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:53:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:53:16 INFO - Running setup.py install for requests 14:53:16 INFO - Running setup.py install for docopt 14:53:17 INFO - Successfully installed blobuploader requests docopt 14:53:17 INFO - Cleaning up... 14:53:17 INFO - Return code: 0 14:53:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:53:17 INFO - Using env: {'DISPLAY': ':0', 14:53:17 INFO - 'HOME': '/home/cltbld', 14:53:17 INFO - 'LANG': 'en_US.UTF-8', 14:53:17 INFO - 'LANGUAGE': 'en_US:en', 14:53:17 INFO - 'LOGNAME': 'cltbld', 14:53:17 INFO - 'MAIL': '/var/mail/cltbld', 14:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:17 INFO - 'MOZ_NO_REMOTE': '1', 14:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:17 INFO - 'NO_EM_RESTART': '1', 14:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:17 INFO - 'PWD': '/builds/slave/test', 14:53:17 INFO - 'SHELL': '/bin/bash', 14:53:17 INFO - 'SHLVL': '1', 14:53:17 INFO - 'TERM': 'linux', 14:53:17 INFO - 'TMOUT': '86400', 14:53:17 INFO - 'USER': 'cltbld', 14:53:17 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:17 INFO - '_': '/tools/buildbot/bin/python'} 14:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:17 INFO - Running setup.py (path:/tmp/pip-8HJ7ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:17 INFO - Running setup.py (path:/tmp/pip-qzQkfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:17 INFO - Running setup.py (path:/tmp/pip-15nMXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:17 INFO - Running setup.py (path:/tmp/pip-7ieJFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:17 INFO - Running setup.py (path:/tmp/pip-kqswDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:17 INFO - Running setup.py (path:/tmp/pip-gT_2RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:17 INFO - Running setup.py (path:/tmp/pip-AKMK6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:17 INFO - Running setup.py (path:/tmp/pip-KyIK9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:17 INFO - Running setup.py (path:/tmp/pip-wLitcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:17 INFO - Running setup.py (path:/tmp/pip-uvxNQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:17 INFO - Running setup.py (path:/tmp/pip-u9p11e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:17 INFO - Running setup.py (path:/tmp/pip-GS6Frm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:17 INFO - Running setup.py (path:/tmp/pip-GNXEAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:18 INFO - Running setup.py (path:/tmp/pip-iOREjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:18 INFO - Running setup.py (path:/tmp/pip-uLTQ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:18 INFO - Running setup.py (path:/tmp/pip-bfsonp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:18 INFO - Running setup.py (path:/tmp/pip-DibDWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:53:18 INFO - Running setup.py install for manifestparser 14:53:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Running setup.py install for mozcrash 14:53:18 INFO - Running setup.py install for mozdebug 14:53:18 INFO - Running setup.py install for mozdevice 14:53:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Running setup.py install for mozfile 14:53:18 INFO - Running setup.py install for mozhttpd 14:53:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Running setup.py install for mozinfo 14:53:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Running setup.py install for mozInstall 14:53:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:53:18 INFO - Running setup.py install for mozleak 14:53:19 INFO - Running setup.py install for mozlog 14:53:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Running setup.py install for moznetwork 14:53:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Running setup.py install for mozprocess 14:53:19 INFO - Running setup.py install for mozprofile 14:53:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Running setup.py install for mozrunner 14:53:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Running setup.py install for mozscreenshot 14:53:19 INFO - Running setup.py install for moztest 14:53:19 INFO - Running setup.py install for mozversion 14:53:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:53:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:53:19 INFO - Cleaning up... 14:53:19 INFO - Return code: 0 14:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53: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:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:19 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 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:19 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:53:19 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:53:19 INFO - Using env: {'DISPLAY': ':0', 14:53:19 INFO - 'HOME': '/home/cltbld', 14:53:19 INFO - 'LANG': 'en_US.UTF-8', 14:53:19 INFO - 'LANGUAGE': 'en_US:en', 14:53:19 INFO - 'LOGNAME': 'cltbld', 14:53:19 INFO - 'MAIL': '/var/mail/cltbld', 14:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:19 INFO - 'MOZ_NO_REMOTE': '1', 14:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:19 INFO - 'NO_EM_RESTART': '1', 14:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:19 INFO - 'PWD': '/builds/slave/test', 14:53:19 INFO - 'SHELL': '/bin/bash', 14:53:19 INFO - 'SHLVL': '1', 14:53:19 INFO - 'TERM': 'linux', 14:53:19 INFO - 'TMOUT': '86400', 14:53:19 INFO - 'USER': 'cltbld', 14:53:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:19 INFO - '_': '/tools/buildbot/bin/python'} 14:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:53:20 INFO - Running setup.py (path:/tmp/pip-y9avJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:53:20 INFO - Running setup.py (path:/tmp/pip-MONbps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:53:20 INFO - Running setup.py (path:/tmp/pip-6T2ltW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:53:20 INFO - Running setup.py (path:/tmp/pip-AFj9Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:53:20 INFO - Running setup.py (path:/tmp/pip-Un4BY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:53:20 INFO - Running setup.py (path:/tmp/pip-QsW21i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:53:20 INFO - Running setup.py (path:/tmp/pip-_70yce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:53:20 INFO - Running setup.py (path:/tmp/pip-c6y1I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:53:20 INFO - Running setup.py (path:/tmp/pip-CV1wLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:53:20 INFO - Running setup.py (path:/tmp/pip-cFvgZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:53:20 INFO - Running setup.py (path:/tmp/pip-oKXSEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:53:20 INFO - Running setup.py (path:/tmp/pip-9YnvNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:53:20 INFO - Running setup.py (path:/tmp/pip-MZMkwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:53:20 INFO - Running setup.py (path:/tmp/pip-v_zhFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:20 INFO - Running setup.py (path:/tmp/pip-DG5PN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:53:20 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:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:53:20 INFO - Running setup.py (path:/tmp/pip-x53gRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:53:21 INFO - Running setup.py (path:/tmp/pip-NRVdX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:53:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:22 INFO - Downloading blessings-1.6.tar.gz 14:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:53:22 INFO - Installing collected packages: blessings 14:53:22 INFO - Running setup.py install for blessings 14:53:23 INFO - Successfully installed blessings 14:53:23 INFO - Cleaning up... 14:53:23 INFO - Return code: 0 14:53:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:53:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:23 INFO - Reading from file tmpfile_stdout 14:53:23 INFO - Current package versions: 14:53:23 INFO - argparse == 1.2.1 14:53:23 INFO - blessings == 1.6 14:53:23 INFO - blobuploader == 1.2.4 14:53:23 INFO - docopt == 0.6.1 14:53:23 INFO - manifestparser == 1.1 14:53:23 INFO - mozInstall == 1.12 14:53:23 INFO - mozcrash == 0.17 14:53:23 INFO - mozdebug == 0.1 14:53:23 INFO - mozdevice == 0.48 14:53:23 INFO - mozfile == 1.2 14:53:23 INFO - mozhttpd == 0.7 14:53:23 INFO - mozinfo == 0.9 14:53:23 INFO - mozleak == 0.1 14:53:23 INFO - mozlog == 3.1 14:53:23 INFO - moznetwork == 0.27 14:53:23 INFO - mozprocess == 0.22 14:53:23 INFO - mozprofile == 0.28 14:53:23 INFO - mozrunner == 6.11 14:53:23 INFO - mozscreenshot == 0.1 14:53:23 INFO - mozsystemmonitor == 0.0 14:53:23 INFO - moztest == 0.7 14:53:23 INFO - mozversion == 1.4 14:53:23 INFO - psutil == 3.1.1 14:53:23 INFO - requests == 1.2.3 14:53:23 INFO - wsgiref == 0.1.2 14:53:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:53: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:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:23 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 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:23 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:53:23 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:53:23 INFO - Using env: {'DISPLAY': ':0', 14:53:23 INFO - 'HOME': '/home/cltbld', 14:53:23 INFO - 'LANG': 'en_US.UTF-8', 14:53:23 INFO - 'LANGUAGE': 'en_US:en', 14:53:23 INFO - 'LOGNAME': 'cltbld', 14:53:23 INFO - 'MAIL': '/var/mail/cltbld', 14:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:23 INFO - 'MOZ_NO_REMOTE': '1', 14:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:23 INFO - 'NO_EM_RESTART': '1', 14:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:23 INFO - 'PWD': '/builds/slave/test', 14:53:23 INFO - 'SHELL': '/bin/bash', 14:53:23 INFO - 'SHLVL': '1', 14:53:23 INFO - 'TERM': 'linux', 14:53:23 INFO - 'TMOUT': '86400', 14:53:23 INFO - 'USER': 'cltbld', 14:53:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:23 INFO - '_': '/tools/buildbot/bin/python'} 14:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 INFO - Cleaning up... 14:53:23 INFO - Return code: 0 14:53:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:53: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:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:23 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 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:23 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:53:23 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:53:23 INFO - Using env: {'DISPLAY': ':0', 14:53:23 INFO - 'HOME': '/home/cltbld', 14:53:23 INFO - 'LANG': 'en_US.UTF-8', 14:53:23 INFO - 'LANGUAGE': 'en_US:en', 14:53:23 INFO - 'LOGNAME': 'cltbld', 14:53:23 INFO - 'MAIL': '/var/mail/cltbld', 14:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:23 INFO - 'MOZ_NO_REMOTE': '1', 14:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:23 INFO - 'NO_EM_RESTART': '1', 14:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:23 INFO - 'PWD': '/builds/slave/test', 14:53:23 INFO - 'SHELL': '/bin/bash', 14:53:23 INFO - 'SHLVL': '1', 14:53:23 INFO - 'TERM': 'linux', 14:53:23 INFO - 'TMOUT': '86400', 14:53:23 INFO - 'USER': 'cltbld', 14:53:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:23 INFO - '_': '/tools/buildbot/bin/python'} 14:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:23 INFO - Downloading/unpacking jsonschema 14:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:23 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:53:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:53:25 INFO - Downloading/unpacking functools32 (from jsonschema) 14:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:25 INFO - Downloading functools32-3.2.3-2.tar.gz 14:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:53:25 INFO - warning: no files found matching '*.txt' 14:53:25 INFO - no previously-included directories found matching 'build' 14:53:25 INFO - no previously-included directories found matching 'dist' 14:53:25 INFO - no previously-included directories found matching '.git*' 14:53:25 INFO - Installing collected packages: jsonschema, functools32 14:53:25 INFO - Running setup.py install for functools32 14:53:25 INFO - warning: no files found matching '*.txt' 14:53:25 INFO - no previously-included directories found matching 'build' 14:53:25 INFO - no previously-included directories found matching 'dist' 14:53:25 INFO - no previously-included directories found matching '.git*' 14:53:25 INFO - Successfully installed jsonschema functools32 14:53:25 INFO - Cleaning up... 14:53:26 INFO - Return code: 0 14:53:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:53: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:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53: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:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:26 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 0x7fc45f8a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1389770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, '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': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', '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:53:26 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:53:26 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:53:26 INFO - Using env: {'DISPLAY': ':0', 14:53:26 INFO - 'HOME': '/home/cltbld', 14:53:26 INFO - 'LANG': 'en_US.UTF-8', 14:53:26 INFO - 'LANGUAGE': 'en_US:en', 14:53:26 INFO - 'LOGNAME': 'cltbld', 14:53:26 INFO - 'MAIL': '/var/mail/cltbld', 14:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:26 INFO - 'MOZ_NO_REMOTE': '1', 14:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:26 INFO - 'NO_EM_RESTART': '1', 14:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:26 INFO - 'PWD': '/builds/slave/test', 14:53:26 INFO - 'SHELL': '/bin/bash', 14:53:26 INFO - 'SHLVL': '1', 14:53:26 INFO - 'TERM': 'linux', 14:53:26 INFO - 'TMOUT': '86400', 14:53:26 INFO - 'USER': 'cltbld', 14:53:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:26 INFO - '_': '/tools/buildbot/bin/python'} 14:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:26 INFO - Downloading/unpacking flake8 14:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:53:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:53:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:53:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:28 INFO - no previously-included directories found matching 'docs/_build' 14:53:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:53:28 INFO - Running setup.py install for pep8 14:53:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:53:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:53:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:53:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:53:28 INFO - no previously-included directories found matching 'docs/_build' 14:53:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:53:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:53:28 INFO - Cleaning up... 14:53:28 INFO - Return code: 0 14:53:28 INFO - Running post-action listener: _resource_record_post_action 14:53:28 INFO - Running post-action listener: _start_resource_monitoring 14:53:28 INFO - Starting resource monitoring. 14:53:28 INFO - ##### 14:53:28 INFO - ##### Finished create-virtualenv step (success) 14:53:28 INFO - ##### 14:53:28 INFO - ##### 14:53:28 INFO - ##### Running install step. 14:53:28 INFO - ##### 14:53:28 INFO - Running pre-action listener: _resource_record_pre_action 14:53:28 INFO - Running main action method: install 14:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:53:29 INFO - Reading from file tmpfile_stdout 14:53:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:53:29 INFO - Reading from file tmpfile_stdout 14:53:29 INFO - Output received: 14:53:29 INFO - Usage: mozinstall [options] installer 14:53:29 INFO - Options: 14:53:29 INFO - -h, --help show this help message and exit 14:53:29 INFO - -d DEST, --destination=DEST 14:53:29 INFO - Directory to install application into. [default: 14:53:29 INFO - "/builds/slave/test"] 14:53:29 INFO - --app=APP Application being installed. [default: firefox] 14:53:29 INFO - mkdir: /builds/slave/test/build/application 14:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:53:45 INFO - Reading from file tmpfile_stdout 14:53:45 INFO - Output received: 14:53:45 INFO - /builds/slave/test/build/application/firefox/firefox 14:53:45 INFO - Running post-action listener: _resource_record_post_action 14:53:45 INFO - ##### 14:53:45 INFO - ##### Finished install step (success) 14:53:45 INFO - ##### 14:53:45 INFO - ##### 14:53:45 INFO - ##### Running run-tests step. 14:53:45 INFO - ##### 14:53:45 INFO - Running pre-action listener: _resource_record_pre_action 14:53:45 INFO - Running main action method: run_tests 14:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:53:45 INFO - Python 2.7.3 14:53:45 INFO - Return code: 0 14:53:45 INFO - grabbing minidump binary from tooltool 14:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:45 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 0x14189c0>, '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 0x14198c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1419d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:53:45 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:53:45 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:53:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:53:45 INFO - Return code: 0 14:53:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:53:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:53:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:53:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:53:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:53:46 INFO - Return code: 0 14:53:46 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/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:53:46 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/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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:53:46 INFO - Using env: {'DISPLAY': ':0', 14:53:46 INFO - 'HOME': '/home/cltbld', 14:53:46 INFO - 'LANG': 'en_US.UTF-8', 14:53:46 INFO - 'LANGUAGE': 'en_US:en', 14:53:46 INFO - 'LOGNAME': 'cltbld', 14:53:46 INFO - 'MAIL': '/var/mail/cltbld', 14:53:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:53:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:46 INFO - 'MOZ_NO_REMOTE': '1', 14:53:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:46 INFO - 'NO_EM_RESTART': '1', 14:53:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:46 INFO - 'PWD': '/builds/slave/test', 14:53:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:53:46 INFO - 'SHELL': '/bin/bash', 14:53:46 INFO - 'SHLVL': '1', 14:53:46 INFO - 'TERM': 'linux', 14:53:46 INFO - 'TMOUT': '86400', 14:53:46 INFO - 'USER': 'cltbld', 14:53:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318', 14:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:46 INFO - '_': '/tools/buildbot/bin/python'} 14:53:46 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/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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:53:46 INFO - mozversion application_buildid: 20160509143200 14:53:46 INFO - mozversion application_changeset: 335e95e6cdc528b60638b2a9802071f8143fe854 14:53:46 INFO - mozversion application_display_name: Nightly 14:53:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:53:46 INFO - mozversion application_name: Firefox 14:53:46 INFO - mozversion application_remotingname: firefox 14:53:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:53:46 INFO - mozversion application_vendor: Mozilla 14:53:46 INFO - mozversion application_version: 49.0a1 14:53:46 INFO - mozversion platform_buildid: 20160509143200 14:53:46 INFO - mozversion platform_changeset: 335e95e6cdc528b60638b2a9802071f8143fe854 14:53:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:53:46 INFO - mozversion platform_version: 49.0a1 14:53:46 INFO - using testdate: 1462830826 14:53:46 INFO - actual date: 1462830826 14:53:46 INFO - starting webserver on 'localhost:56579' 14:53:46 INFO - SUITE-START | Running 2 tests 14:53:46 INFO - TEST-START | dromaeo_css 14:53:46 INFO - operating with platform_type : linux_ 14:53:46 INFO - Initialising browser for dromaeo_css test... 14:53:46 INFO - TEST-INFO | started process 3033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WActW/profile http://localhost:56579/getInfo.html) 14:53:49 INFO - PROCESS | 3033 | 14:53:49 INFO - PROCESS | 3033 | (process:3099): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:53:50 INFO - PROCESS | 3033 | __metrics Screen width/height:1600/1200 14:53:50 INFO - PROCESS | 3033 | colorDepth:24 14:53:50 INFO - PROCESS | 3033 | Browser inner width/height: 1024/697 14:53:50 INFO - PROCESS | 3033 | __metrics 14:53:51 ERROR - PROCESS | 3033 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 14:53:52 INFO - TEST-INFO | 3033: exit 0 14:53:52 INFO - Browser initialized. 14:53:52 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:52 INFO - TEST-INFO | started process 3150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2WActW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:53 INFO - PROCESS | 3150 | 14:53:53 INFO - PROCESS | 3150 | (process:3211): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:54:03 INFO - PROCESS | 3150 | RSS: Main: 163385344 14:54:03 INFO - PROCESS | 3150 | 14:54:53 INFO - PROCESS | 3150 | 1462830893416 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:57:05 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56579/tests/dromaeo/cssquery-ext.html) 14:57:06 INFO - PROCESS | 3150 | RSS: Main: 166879232 14:57:06 INFO - PROCESS | 3150 | 15:00:08 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-ext.html (next: http://localhost:56579/tests/dromaeo/cssquery-jquery.html) 15:00:09 INFO - PROCESS | 3150 | RSS: Main: 165961728 15:00:09 INFO - PROCESS | 3150 | 15:03:10 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56579/tests/dromaeo/cssquery-mootools.html) 15:03:11 INFO - PROCESS | 3150 | RSS: Main: 167116800 15:03:11 INFO - PROCESS | 3150 | 15:06:13 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56579/tests/dromaeo/cssquery-prototype.html) 15:06:13 INFO - PROCESS | 3150 | RSS: Main: 165056512 15:06:13 INFO - PROCESS | 3150 | 15:09:16 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56579/tests/dromaeo/cssquery-yui.html) 15:09:17 INFO - PROCESS | 3150 | RSS: Main: 166359040 15:09:17 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:56579/tests/dromaeo/cssquery-yui.html (next: http://localhost:56579/tests/dromaeo/cssquery-dojo.html) 15:12:19 INFO - PROCESS | 3150 | RSS: Main: 168050688 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | __start_tp_report 15:12:19 INFO - PROCESS | 3150 | _x_x_mozilla_page_load 15:12:19 INFO - PROCESS | 3150 | _x_x_mozilla_page_load_details 15:12:19 INFO - PROCESS | 3150 | |i|pagename|runs| 15:12:19 INFO - PROCESS | 3150 | |0;dojo.html;2641.8679066046693;2669.6395986541834;2703.2025552462023;2724.3733941193527;2730.3037725380027;4767.284907263912;4791.568758811706;4793.304970779235;4820.5420485053955;4874.6831455955335;4632.467266264381;4783.9760801196035;4798.784054717537;4842.934554398035;4846.612271018319;4411.64706823455;4491.932621010687;4539.251023581105;4552.0668263006;4594.264917613183;4462.665300102489;4527.615152712024;4552.203364411232;4589.701669391479;4612.907741845161;4318.3090705486975;4359.411479450266;4369.541198174209;4376.606105450524;4455.532169122261;4399.824007039714;4404.69167158299;4404.889877753049;4428.822847086113;4452.799624016927;4415.7350558966245;4418.248897687401;4421.535738747418;4433.13553856998;4445.599896009375;4626.722396656178;4674;4684.3910291662205;4685.461171965199;4698.436187657503;5052.191649336125;5088.084144853925;5092.770825312869;5098.490150984909;5125.794968201268;5095.0574143783515;5136.974315128437;5148.742562871841;5158.329417175743;5159.406668233164;4818.204996175627;4860.659753817269;4863.076015557032;4865.5864251539015;4892.2661600760175;5246.895062098813;5323;5326.280952071498;5342.519173274346;5385.623006389594;4932.8520144395725;5058.317127187783;5103.0049140418005;5118.078745825713;5129.204973229155;5129.64092513528;5133.307003554472;5147.974260128675;5186.896262074737;5195.9740201298755;4932.679375840559;5013.949860501349;5037.093323201859;5079.111155547765;5083.110455670243;5001.074801161724;5033.697978121324;5053.393592768891;5073.086844367976;5107.438181799999;4244.151169765997;4325;4347.282698354736;4377.387165796791;4427.29163333865;3778.905527361838;3827.4067519534515;3834.1564855731694;3839.788811615388;3884.825182866721;4356.150550642657;4381.890452738707;4428.933565996513;4439.134368798053;4445.844395446144;4877.975610121997;5108.693478391308;5122.974385128051;5186.170212766015;5205.193195054772;4398.296272596369;4412.139632771643;4429;4432.31299148626;4504.909901801946;4685.718856868599;4703.223968045234;4707.741074240881;4723.645726570521;4762.523747625279;4656.185167595657;4703.412073490814;4734.905301894012;4735.905281894274;4739.4075740532435;5034.421041580119;5040.974795126001;5042.899142017066;5042.974785126197;5096.566791822588;4713.528647135259;4743.573078422958;4748.406449193851;4752.073345697694;4787.497312782108;5047.091523525801;5066.290719299374;5087.516685914832;5104.1067813133295;5111.156659151347;5170.5346518813485;5198.428172901054;5207.140821764367;5226.372835259793;5253.080710875505;4794.4486384064885;4942.3080768693135;5026.773795179152;5035.118854200574;5044.495550444926;4763.333133361401;4892.633052521004;4938.135826230324;4974.726390048582;5076.949230507647;4845.927311090266;4890.633202509897;4892.192788190051;4898.167311556973;4903.705777653352;4818.4217893852965;4974.154393752999;5004.724740139327;5019.3976722793495;5037.571806396498;4893.657443978887;4956.677815941952;4980.452150263541;4982.302477653204;4988.052270068675 15:12:19 INFO - PROCESS | 3150 | |1;ext.html;556.7605929450336;572.4761842913734;581.2182614383654;593.5103539579845;621.0776996160704;34753.82623086884;38112.618873811254;38257;38405.423918641245;38770.41844372336;39265.21469570607;40192.59807401925;40237.19525609486;40266.7986660067;40303.79848100763;7714.228577142283;7846.293833554979;7886.6451009704415;7905.090914544815;7915.920840791576;7789.532628042307;7810.258025487569;7840.372770178372;7871.645775940096;7872.252136047066;7817.335526480228;7833.64748586315;7863.449558530905;7897.842043159133;7926.365890728756;7804;7821.882671759929;7833.490823096509;7855.371570274393;7883.132855385903;7683.385329173652;7751.147373788879;7780.494267872627;7797.649105790197;7802.921970780277;36608;36771.81614091939;36859;36944;37053.629463705285;3140.811551306929;3182.458981973047;3270.591176102987;3289.0297362278184;3476.739244556643;28605.28486787826;28828.855855720798;28935;29107.85446072756;29503.262418439495;3470.132466883279;3471.409860323751;3549.396602577568;3550.5029295898594;3594.622564630702;233561;234646;235114.99999999828;235814;238041;52338.73830630899;52365.47634523606;52462;52549.7372513135;52906.735466322425;33983.4902476463;35118.29763404769;35418.46872296918;37451.25097498035;37721.245575088346;13141.605751827461;13233;13236.602901912958;13248.20510769357;13307.933460332637;9441.52792360393;9496.43021418717;9497.335186536877;9525.5713492893;9556.61773529051;18392.724109138373;18545.258189672262;18605.441836744918;18682.34611788581;18747.90626046861;7118.857622847514;7205.92794072063;7217.206107328189;7244.746433874789;7312.853742925112;852.3905407633572;981.788915383196;986.7631768375538;1004.633308842282;1015.7663737340305;25655.871720641277;26725.0646227385;26857.328566785596;26996.730032699816;27228;957.4494665567327;1025.553884060436;1040.8646875906084;1066.4774260612398;1089.6760436070213;14474.203918784568;14665.48670796517;14790.482333118289;14999.475018374305;15000.62498437526;373105;379579;382014;383005;385477;49223.26165107526;49789.751051244515;49802.501974980514;49860;49945.500544994815;1261.4197469164103;1269.8984081273477;1281.4297637551388;1283.6598301450124;1286.2604002698486;25718.87140564285;26816.854651627433;26982;27266.591001134602;27482.725172748018;42235.577644223165;42370.576294236664;42389.36415953701;42768.936950989606;42832;306120;315488;315767.52697419113;315830;317012;25200.117995870056;25779.226623201335;25802;25811.612825808003;25827.225183244533;40917.59082409138;42634;42723.5727642732;43057.354139687304;43473.130537389705;34756.65243347635;36040;36457.817710912335;36480.81759591185;36588.634113658525;35594.64405355913;36122.63877361193;36480.63519364772;36519.81740091283;37111.25777484489;35223.29553408866;35527.64472355243;35934.8203258982;36464;36529.63470365262;30219;31865.840670796497;32277.838610806797;32407;32419.513707293936;24456;27321.72678273192;27828;28015.859920700266;28132.43735125245 15:12:19 INFO - PROCESS | 3150 | |2;jquery.html;367.1848496338129;369.83172656441315;373.5629313702967;383.8656470235416;391.67882336484075;16006.119663418522;16150.273237704303;17295.91352043238;17432.38986635468;17475.038872861987;16586.25361858716;16867.746983795223;17867.374641887538;17928.103594820273;17931.91034044828;4799.184138696412;5130.050940576006;5172.40517340505;5181.689098654074;5186.299849520305;4905.3132561441425;5060.6963582185;5141.614378921578;5145.305383773199;5148.124818780816;5078.873028174288;5083.212102124176;5087.567556757662;5098.388193416795;5128.358955130609;4835.298881662175;4872.488388719186;4934.901301973959;5097.158968770167;5115.335006449138;4569.497355290949;4587.587117159472;4590.472095709003;4594.333821595883;4614.330922016289;15275.923620381938;18527.2589096436;20763.792362076336;21124.15503379863;21158.576828463498;2009.346962237264;2023.908924098419;2031.1570698160247;2046.6009128220003;2539.733328000552;13329.533466328729;13831.239281839595;13834.446622135103;14084.577462676136;14325.64185895361;1735;1740.6779745747078;1795.3805936951862;1802.4502526729343;1873.0728289496785;65413;66369.01785892814;67980.3201967979;68642.65678671574;69209.65395172992;8317.126701696356;9137.223336016381;9159.358844880795;9374.484403357745;9498.382605130644;12411.441485133191;12430.689232769073;12465.626031219077;12480.875191248153;12505.93747031259;6627.536072474977;6781.966090169518;6813.046173535709;6831.931680683129;6890.689918953659;6576.80269591913;6584.814733347947;6609.20689517261;6657.068010478537;6668.83327916806;3893.1507533921163;3962.5443074046275;3971.980140099281;3982.6216509431556;3992.121733218687;1837.9816201838078;1865.6268746250805;1902.781180164271;1971.9211231550578;1982.4548249231577;793.5040599625235;845.0577605969423;895.7402353317595;936.3679516326589;956.3735753081743;16461.25924333408;17095.316187352615;17290.481285561455;17311.468238779467;17716.557086072695;874.8206617643368;876.5573385440312;883.726044926075;915.9358844880794;933.5658918602883;9607.711768646952;9850;9888.555015024342;9994.300398972002;10021.198304135653;388502;390063;403216;403420;412507;80768;82169;83495.582522087;83703.58148209342;83972.58013709892;937.6577549194632;948.4167237149104;951.8762560867043;962.7208109648124;964.5322018820866;15039.398424063353;15118.773218401513;15171.772423413437;15468.690626187188;15681.372745090068;35181;35755.821220893726;35863.82068089747;36004;36257.27485450223;46321.305180421645;48901.75549122231;49592.256116157565;49970;50087.24869127039;7685.615719214129;7687.154413014452;7718.807029824299;7835.725749598737;7869.606519673879;8660.047394786443;10804.67585972422;11619.477123529292;11710.414479276173;11761.705957351134;9965.50172491358;10036.849447258443;10450.42522661261;10624.734381640212;10630.681079567625;10276.588936442458;10312.123469505175;10453.006964338376;10520.947395262974;10739.087177589992;10361.171106311327;10556.155507559222;10660.200484963814;10660.413677247825;10834.241603088023;7791.571463569331;7844.882326764989;7921.920780792118;8069.83860322802;8106.959465202636;9635.710928672152;10546.20903432261;10593.576256949944;10730.087942524973;10772.784544308914 15:12:19 INFO - PROCESS | 3150 | |3;mootools.html;1435.6195608163835;1461.3570029187156;1568.1845440371007;1735.739639054141;1736.3054778088772;6332.683365831702;6970.477214208936;7040.29597040297;7250.274972502753;7284.672189751461;7126.32299931507;7414.518056326335;7416.888746668804;7432.331090201881;7444.143923448805;2137.625915464795;2175.4778853075227;2178.16140785797;2178.553396553703;2181.792729690677;2126.26643807886;2133.221374198422;2152.117631770974;2154.2244791874914;2172.630652789022;2143.142742902836;2158.5467051919118;2173.0547211962767;2175.967360489594;2177.68423578581;2087.530305681217;2087.8642888212294;2094.371688493461;2097.0039231365054;2103.7265155529835;2045.734054572896;2082.937511874646;2091.393495886191;2092.4350425385214;2095.98952005239;7338;7469.2904174103915;7496.212897645723;7496.8125796854965;7517.135529414078;4272.060146767706;4419.204543182226;4450.777461126931;4453.621442177418;4456.064226512404;2834.433113377312;2844.48799216141;3012.186709588421;3020.652624948137;3021.2748940254182;873.5937788928179;919.4069824962928;933.2440723014312;945.3477100800426;958.8226178156993;9251;9366.67216647414;9387.295952803499;9453.763655908588;9669.854952175723;4015.8393664253686;4033.878983630496;4035.7174997749876;4061.411095391211;4137.689673274516;8134.105248422668;8312.127226641236;8319.916800832036;8459.238668519863;8515.57422128891;4251.574842515785;4281.593248641374;4404.757738324423;4443.466783985878;4457.955420445754;3489.3195826813526;3763.8682646107254;3926.5680775114715;4079.7756123412905;4106.527749308868;3533.2756784859043;3568.892933212008;3590.353736327434;3619.8371073301237;3717.070732316921;1199.9280043197436;1202.4649031181216;1203.0556013529338;1204.7590481903653;1215.9939200303943;661.798151563768;766.501773847004;819.647551552826;837.3175861672718;865.8268346330759;4839.637027222972;5027.069992051483;5047.899042019212;5099.031184075014;5119.564836988898;867.5141920524401;874.7944233105216;877.9868301975475;894.5035505294494;922.8154369126202;3427.4344733118755;3452.861885524551;3469.826508674556;3505.544279243682;3538.4515400113023;8761.474311541328;8886.289096872364;9084.364094513321;9170.037146099563;9205.263578913671;8985.775355616031;9005.774855628531;9090.500022498825;9094.18152366277;9113.589888455035;6856.211535673461;7111.502194846415;7119.7864064079195;7133.82165445868;7170.749023784142;4880;4886.218205087169;4947.406311242674;5052.494750524918;5061.6962982221185;8033.517988920684;8364.247217750188;8479.533625650649;8520.61657225414;8597.699080532151;8528.701495447629;8542.82914341722;8597.742067737978;8714.91285087141;8730.17063378978;5441.727913604224;5874.970625146847;6018.518518518596;6104.38956104386;6242.906356404748;7145.82135446618;7165.319294666998;7205.423566114803;7238.6380680964685;7249.275072492708;6339.080833279057;6459.321771213955;6514.0880276760345;6621.238557565942;6783.423409010092;6568.6537639539765;6580.1116849224745;6589.835254118685;6610.9669451652435;6657.167854018247;6037.426444487766;6063.363346848694;6123.2652081750475;6131.601445906002;6162.983107787165;4464.55354464564;4492.955070449254;4560.270356742905;4625.676202665781;4690.554397332248;4589.541045895384;4614.4693360264;4648.604868586208;4699.812007519798;4713.835015774432 15:12:19 INFO - PROCESS | 3150 | |4;prototype.html;302.47218603536817;311.76150245062524;318.442725230846;320.94062598419293;322.72890771751725;4702.9529704702945;4795.59237464815;4823.541763532463;4903.215485522322;4910.042541704364;4794.448638406576;4800.927986080212;4836.661433699643;4838.927416088753;4864.805407783693;3785.2429514097153;3812.8284227209842;3821.216650586623;3830.578636349999;3831.8275677594575;3713.3501637213517;3809.314323421783;3845.8846234613006;3849.9027777083397;3860.4595356650093;3757.3800322946818;3763.7929913854728;3779.829907654162;3781;3787.185755062661;3743.9625603743884;3772.207836354355;3781.111438811877;3785.470034195215;3785.5268091488565;3388.1868351595685;3392.23674673199;3394.251960240478;3398.4732366483236;3422.281320922609;4412.536683648203;4693.460252071021;4716.716996980193;4749.596284315838;4750.954789946206;4197.433346498245;4200.15996800638;4204.369344598304;4270.295401258789;4278.935815962763;5016.523430274155;5033.597312215014;5050.217216331474;5055.828941123587;5105.085592902661;3621.4567814827988;3627.1838836261895;3635.4183330666965;3641.326354624403;3671.971847882597;4927.43334516528;5318.946810531884;5321.813736519242;5329.786808527654;5364.946350536523;3646.890593282206;3682.4476328550395;3701.9259614808093;3711;3720.2187540616233;3745.5318085239346;3747.362948298796;3753.0804952786743;3766.114962983697;3767.7550959187565;4069.1861627674584;4229.703920725581;4255.8084886180195;4277.1873344064525;4286.657067434598;5020.196768517093;5073.416557095908;5092.9236061459105;5096.770645320969;5104.795808167706;1187.8396416483838;1209.1535924852637;1216.5583783216916;1246.1401632873287;1246.3456685240321;845.6955496021427;854.1842540373927;864.4208380385157;865.5672163918041;877.859542473214;4156.293430116887;4167.562405947392;4168.979155104265;4196.979015104966;4236.533981262059;4942.481039490802;4972.403311602631;4977.552020318189;4979.601631869442;5032.924506132411;4174.749515029108;4207.495100587949;4217.957820421818;4238.851640192578;4243.787810609457;2467.3338198686256;2627.2249686342575;2641.543364670836;2676;2692.3269182704325;4738.431388233365;4768.594669453066;4782.206672497813;4783.942904551007;4807.423109226846;5164.32863727713;5167.276581278624;5172.844814655567;5174.663646862942;5229.607779416559;4577.473590537064;4744.857654270378;4750.976245118753;4775.116603428377;4776.2119250324;5025.572826309804;5029.170186919117;5049.444561098203;5105.417320630617;5145.45972672864;4965.900681986413;4971.414864270631;4992.525710057539;5012.77442515095;5016.272640467038;4619.69971951822;4960.429550601727;4966.528179822911;4971.825986090469;4976.32819569368;3636.7999760013454;3677.9632203678693;3710.128119891769;3710.666040056408;3719.367707489679;5012.223105418666;5263.394709608444;5269.841904742864;5277.788888444419;5341.519263266325;4932.482089380564;5099.796008159632;5102.260172274925;5103.974480127576;5106.183010718416;5045.470225626404;5086.669366491166;5116.7441627917715;5138.614603904797;5144.536991670768;4846.321514987834;4997.9750101249265;5022.438556336368;5049.419316778617;5053.448008755555;5105.6426050177615;5105.693658380509;5122.974385128051;5137.280780690631;5147;4998.950010499849;5020.799168033238;5047.712833227651;5066.265391518283;5072.300779238996 15:12:19 INFO - PROCESS | 3150 | |5;yui.html;733.4205977277951;742.5952855693643;748.943829212809;788.9171636978116;794.6463823598501;12638.936805315972;13572.185668859875;13590.388432520536;13987;14036.298185090756;13851.376688049037;13855.653608659763;13939.651508712288;13948.930255348734;13988.580342589714;653.2194028136379;861.2378045429792;870.2950610005884;871.834351473218;872.4198408058634;845.4039901869198;881.7002219245455;882.4484697064335;884.385352180235;888.8089060851947;899.6356475627381;909.9317551183655;913.6071489259616;916.839553078212;917.3899356927635;901.8782464367292;903.8824952756165;904.1184844776357;906.9818603627923;911.7173676160412;670.0384947600161;671.1208317104608;671.8387586979138;673.0409166937095;676.6177109932872;12557.246565206116;12627.684307892285;12692.555760548428;12701.555445559361;12732.363381830872;10914.945425272823;11715.472803723853;12012;12039.217450865754;12281.69295767613;9658.565364558612;9686.70939871805;9725.756856078584;9955.402675839472;9982.9500852496;3232.143481977278;3262.8531716072835;3318.1704573856537;3365.4615261558033;3371.865125394981;42878.78560607208;43148.137037259396;43246.35130473045;43314.566854331366;43777;9734.464604446823;9867.950660246654;9983.700488985342;10060.446675432922;10073.395596264247;17005.744913826304;17110.0589467578;17131.91434042822;17262.913685431493;17366.39217627377;6453.903191452132;6517.674116294166;6560.639164845884;6621.768238111643;6761.0872532208505;3570;3584.0143960411096;3588.7667301625834;3621.456781482746;3705.4071348584635;2881.423715256957;2973.167513096293;3007.65411977621;3028.37918226763;3033.2568520712566;532.7629402968807;538.4158188365667;544.599719206383;552.4668694709625;555.0148486436607;626.8056902360283;641.5541198866742;649.6719156825773;653.6176336842905;659.7525927777084;8070.515769053758;8073.233042860918;8171.428000040059;8175.48049528543;8272.37957153216;615.7444660465947;638.3265654734207;640.4044238857814;649.2533586375706;665.1423820411572;3600.1179710970455;3751.531058617673;3764.378877485184;3820;3858.324793161242;48359.5164048355;48756.756216218695;49904.50095499071;49961;50253;44161.77919110384;45674.543254567696;45859.31211031837;46167.30749038767;47202;41331;41503;41845.37231941523;41845.58154418417;42384;6648.90026649591;6662.267150613526;6664.766733164316;6671.232808227116;6904.102466679299;28311.575326370534;28564.857175713987;28669.28326791847;28874.566881497216;29370.265743355732;33539.993800186036;34373.312533748685;36259;36594.26811463702;36668.63331366759;8463.74608761738;8625.568721564023;8820.955895220482;8929.241014513838;8992.505412202392;10193.439360835226;10219.386836789816;10231;10253.743656408351;10610.628627997983;8941.687040953795;9237.445753254557;9282.443053416817;9291.767705807139;9307.162355388047;9509.239260858976;9512;9609.711708648752;9971.551280192554;10242.436665983443;9216.585253663467;9221.123993220634;9288.767780805534;9463.337566370288;9710.805783884423;8534.914650853412;8639.199259752992;8685.435446695945;8740.34447416459;8827.16141966512;8333.250007499355;8351.498910065415;8478.23695867375;8709.077827077648;8740.868886966573 15:12:19 INFO - PROCESS | 3150 | __end_tp_report 15:12:19 INFO - PROCESS | 3150 | __start_cc_report 15:12:19 INFO - PROCESS | 3150 | _x_x_mozilla_cycle_collect,322 15:12:19 INFO - PROCESS | 3150 | __end_cc_report 15:12:19 INFO - PROCESS | 3150 | __startTimestamp1462831939586__endTimestamp 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | ------- Summary: start ------- 15:12:19 INFO - PROCESS | 3150 | Number of tests: 6 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#0] dojo.html Cycles:165 Average:4737.44 Median:4845.93 stddev:486.62 (10.0%) stddev-sans-first:459.50 15:12:19 INFO - PROCESS | 3150 | Values: 2641.9 2669.6 2703.2 2724.4 2730.3 4767.3 4791.6 4793.3 4820.5 4874.7 4632.5 4784.0 4798.8 4842.9 4846.6 4411.6 4491.9 4539.3 4552.1 4594.3 4462.7 4527.6 4552.2 4589.7 4612.9 4318.3 4359.4 4369.5 4376.6 4455.5 4399.8 4404.7 4404.9 4428.8 4452.8 4415.7 4418.2 4421.5 4433.1 4445.6 4626.7 4674.0 4684.4 4685.5 4698.4 5052.2 5088.1 5092.8 5098.5 5125.8 5095.1 5137.0 5148.7 5158.3 5159.4 4818.2 4860.7 4863.1 4865.6 4892.3 5246.9 5323.0 5326.3 5342.5 5385.6 4932.9 5058.3 5103.0 5118.1 5129.2 5129.6 5133.3 5148.0 5186.9 5196.0 4932.7 5013.9 5037.1 5079.1 5083.1 5001.1 5033.7 5053.4 5073.1 5107.4 4244.2 4325.0 4347.3 4377.4 4427.3 3778.9 3827.4 3834.2 3839.8 3884.8 4356.2 4381.9 4428.9 4439.1 4445.8 4878.0 5108.7 5123.0 5186.2 5205.2 4398.3 4412.1 4429.0 4432.3 4504.9 4685.7 4703.2 4707.7 4723.6 4762.5 4656.2 4703.4 4734.9 4735.9 4739.4 5034.4 5041.0 5042.9 5043.0 5096.6 4713.5 4743.6 4748.4 4752.1 4787.5 5047.1 5066.3 5087.5 5104.1 5111.2 5170.5 5198.4 5207.1 5226.4 5253.1 4794.4 4942.3 5026.8 5035.1 5044.5 4763.3 4892.6 4938.1 4974.7 5076.9 4845.9 4890.6 4892.2 4898.2 4903.7 4818.4 4974.2 5004.7 5019.4 5037.6 4893.7 4956.7 4980.5 4982.3 4988.1 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#1] ext.html Cycles:180 Average:46019.10 Median:36500.32 stddev:83076.51 (227.6%) stddev-sans-first:83239.43 15:12:19 INFO - PROCESS | 3150 | Values: 556.8 572.5 581.2 593.5 621.1 34753.8 38112.6 38257.0 38405.4 38770.4 39265.2 40192.6 40237.2 40266.8 40303.8 7714.2 7846.3 7886.6 7905.1 7915.9 7789.5 7810.3 7840.4 7871.6 7872.3 7817.3 7833.6 7863.4 7897.8 7926.4 7804.0 7821.9 7833.5 7855.4 7883.1 7683.4 7751.1 7780.5 7797.6 7802.9 36608.0 36771.8 36859.0 36944.0 37053.6 3140.8 3182.5 3270.6 3289.0 3476.7 28605.3 28828.9 28935.0 29107.9 29503.3 3470.1 3471.4 3549.4 3550.5 3594.6 233561.0 234646.0 235115.0 235814.0 238041.0 52338.7 52365.5 52462.0 52549.7 52906.7 33983.5 35118.3 35418.5 37451.3 37721.2 13141.6 13233.0 13236.6 13248.2 13307.9 9441.5 9496.4 9497.3 9525.6 9556.6 18392.7 18545.3 18605.4 18682.3 18747.9 7118.9 7205.9 7217.2 7244.7 7312.9 852.4 981.8 986.8 1004.6 1015.8 25655.9 26725.1 26857.3 26996.7 27228.0 957.4 1025.6 1040.9 1066.5 1089.7 14474.2 14665.5 14790.5 14999.5 15000.6 373105.0 379579.0 382014.0 383005.0 385477.0 49223.3 49789.8 49802.5 49860.0 49945.5 1261.4 1269.9 1281.4 1283.7 1286.3 25718.9 26816.9 26982.0 27266.6 27482.7 42235.6 42370.6 42389.4 42768.9 42832.0 306120.0 315488.0 315767.5 315830.0 317012.0 25200.1 25779.2 25802.0 25811.6 25827.2 40917.6 42634.0 42723.6 43057.4 43473.1 34756.7 36040.0 36457.8 36480.8 36588.6 35594.6 36122.6 36480.6 36519.8 37111.3 35223.3 35527.6 35934.8 36464.0 36529.6 30219.0 31865.8 32277.8 32407.0 32419.5 24456.0 27321.7 27828.0 28015.9 28132.4 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#2] jquery.html Cycles:180 Average:24604.63 Median:403318.00 stddev:66007.38 (16.4%) stddev-sans-first:66167.46 15:12:19 INFO - PROCESS | 3150 | Values: 367.2 369.8 373.6 383.9 391.7 16006.1 16150.3 17295.9 17432.4 17475.0 16586.3 16867.7 17867.4 17928.1 17931.9 4799.2 5130.1 5172.4 5181.7 5186.3 4905.3 5060.7 5141.6 5145.3 5148.1 5078.9 5083.2 5087.6 5098.4 5128.4 4835.3 4872.5 4934.9 5097.2 5115.3 4569.5 4587.6 4590.5 4594.3 4614.3 15275.9 18527.3 20763.8 21124.2 21158.6 2009.3 2023.9 2031.2 2046.6 2539.7 13329.5 13831.2 13834.4 14084.6 14325.6 1735.0 1740.7 1795.4 1802.5 1873.1 65413.0 66369.0 67980.3 68642.7 69209.7 8317.1 9137.2 9159.4 9374.5 9498.4 12411.4 12430.7 12465.6 12480.9 12505.9 6627.5 6782.0 6813.0 6831.9 6890.7 6576.8 6584.8 6609.2 6657.1 6668.8 3893.2 3962.5 3972.0 3982.6 3992.1 1838.0 1865.6 1902.8 1971.9 1982.5 793.5 845.1 895.7 936.4 956.4 16461.3 17095.3 17290.5 17311.5 17716.6 874.8 876.6 883.7 915.9 933.6 9607.7 9850.0 9888.6 9994.3 10021.2 388502.0 390063.0 403216.0 403420.0 412507.0 80768.0 82169.0 83495.6 83703.6 83972.6 937.7 948.4 951.9 962.7 964.5 15039.4 15118.8 15171.8 15468.7 15681.4 35181.0 35755.8 35863.8 36004.0 36257.3 46321.3 48901.8 49592.3 49970.0 50087.2 7685.6 7687.2 7718.8 7835.7 7869.6 8660.0 10804.7 11619.5 11710.4 11761.7 9965.5 10036.8 10450.4 10624.7 10630.7 10276.6 10312.1 10453.0 10520.9 10739.1 10361.2 10556.2 10660.2 10660.4 10834.2 7791.6 7844.9 7921.9 8069.8 8107.0 9635.7 10546.2 10593.6 10730.1 10772.8 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#3] mootools.html Cycles:180 Average:4893.16 Median:5658.35 stddev:2643.03 (46.7%) stddev-sans-first:2637.67 15:12:19 INFO - PROCESS | 3150 | Values: 1435.6 1461.4 1568.2 1735.7 1736.3 6332.7 6970.5 7040.3 7250.3 7284.7 7126.3 7414.5 7416.9 7432.3 7444.1 2137.6 2175.5 2178.2 2178.6 2181.8 2126.3 2133.2 2152.1 2154.2 2172.6 2143.1 2158.5 2173.1 2176.0 2177.7 2087.5 2087.9 2094.4 2097.0 2103.7 2045.7 2082.9 2091.4 2092.4 2096.0 7338.0 7469.3 7496.2 7496.8 7517.1 4272.1 4419.2 4450.8 4453.6 4456.1 2834.4 2844.5 3012.2 3020.7 3021.3 873.6 919.4 933.2 945.3 958.8 9251.0 9366.7 9387.3 9453.8 9669.9 4015.8 4033.9 4035.7 4061.4 4137.7 8134.1 8312.1 8319.9 8459.2 8515.6 4251.6 4281.6 4404.8 4443.5 4458.0 3489.3 3763.9 3926.6 4079.8 4106.5 3533.3 3568.9 3590.4 3619.8 3717.1 1199.9 1202.5 1203.1 1204.8 1216.0 661.8 766.5 819.6 837.3 865.8 4839.6 5027.1 5047.9 5099.0 5119.6 867.5 874.8 878.0 894.5 922.8 3427.4 3452.9 3469.8 3505.5 3538.5 8761.5 8886.3 9084.4 9170.0 9205.3 8985.8 9005.8 9090.5 9094.2 9113.6 6856.2 7111.5 7119.8 7133.8 7170.7 4880.0 4886.2 4947.4 5052.5 5061.7 8033.5 8364.2 8479.5 8520.6 8597.7 8528.7 8542.8 8597.7 8714.9 8730.2 5441.7 5875.0 6018.5 6104.4 6242.9 7145.8 7165.3 7205.4 7238.6 7249.3 6339.1 6459.3 6514.1 6621.2 6783.4 6568.7 6580.1 6589.8 6611.0 6657.2 6037.4 6063.4 6123.3 6131.6 6163.0 4464.6 4493.0 4560.3 4625.7 4690.6 4589.5 4614.5 4648.6 4699.8 4713.8 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#4] prototype.html Cycles:180 Average:4170.18 Median:4759.79 stddev:1211.29 (25.4%) stddev-sans-first:1179.39 15:12:19 INFO - PROCESS | 3150 | Values: 302.5 311.8 318.4 320.9 322.7 4703.0 4795.6 4823.5 4903.2 4910.0 4794.4 4800.9 4836.7 4838.9 4864.8 3785.2 3812.8 3821.2 3830.6 3831.8 3713.4 3809.3 3845.9 3849.9 3860.5 3757.4 3763.8 3779.8 3781.0 3787.2 3744.0 3772.2 3781.1 3785.5 3785.5 3388.2 3392.2 3394.3 3398.5 3422.3 4412.5 4693.5 4716.7 4749.6 4751.0 4197.4 4200.2 4204.4 4270.3 4278.9 5016.5 5033.6 5050.2 5055.8 5105.1 3621.5 3627.2 3635.4 3641.3 3672.0 4927.4 5318.9 5321.8 5329.8 5364.9 3646.9 3682.4 3701.9 3711.0 3720.2 3745.5 3747.4 3753.1 3766.1 3767.8 4069.2 4229.7 4255.8 4277.2 4286.7 5020.2 5073.4 5092.9 5096.8 5104.8 1187.8 1209.2 1216.6 1246.1 1246.3 845.7 854.2 864.4 865.6 877.9 4156.3 4167.6 4169.0 4197.0 4236.5 4942.5 4972.4 4977.6 4979.6 5032.9 4174.7 4207.5 4218.0 4238.9 4243.8 2467.3 2627.2 2641.5 2676.0 2692.3 4738.4 4768.6 4782.2 4783.9 4807.4 5164.3 5167.3 5172.8 5174.7 5229.6 4577.5 4744.9 4751.0 4775.1 4776.2 5025.6 5029.2 5049.4 5105.4 5145.5 4965.9 4971.4 4992.5 5012.8 5016.3 4619.7 4960.4 4966.5 4971.8 4976.3 3636.8 3678.0 3710.1 3710.7 3719.4 5012.2 5263.4 5269.8 5277.8 5341.5 4932.5 5099.8 5102.3 5104.0 5106.2 5045.5 5086.7 5116.7 5138.6 5144.5 4846.3 4998.0 5022.4 5049.4 5053.4 5105.6 5105.7 5123.0 5137.3 5147.0 4999.0 5020.8 5047.7 5066.3 5072.3 15:12:19 INFO - PROCESS | 3150 | 15:12:19 INFO - PROCESS | 3150 | [#5] yui.html Cycles:180 Average:12220.98 Median:639.37 stddev:13832.22 (2163.4%) stddev-sans-first:13844.12 15:12:19 INFO - PROCESS | 3150 | Values: 733.4 742.6 748.9 788.9 794.6 12638.9 13572.2 13590.4 13987.0 14036.3 13851.4 13855.7 13939.7 13948.9 13988.6 653.2 861.2 870.3 871.8 872.4 845.4 881.7 882.4 884.4 888.8 899.6 909.9 913.6 916.8 917.4 901.9 903.9 904.1 907.0 911.7 670.0 671.1 671.8 673.0 676.6 12557.2 12627.7 12692.6 12701.6 12732.4 10914.9 11715.5 12012.0 12039.2 12281.7 9658.6 9686.7 9725.8 9955.4 9983.0 3232.1 3262.9 3318.2 3365.5 3371.9 42878.8 43148.1 43246.4 43314.6 43777.0 9734.5 9868.0 9983.7 10060.4 10073.4 17005.7 17110.1 17131.9 17262.9 17366.4 6453.9 6517.7 6560.6 6621.8 6761.1 3570.0 3584.0 3588.8 3621.5 3705.4 2881.4 2973.2 3007.7 3028.4 3033.3 532.8 538.4 544.6 552.5 555.0 626.8 641.6 649.7 653.6 659.8 8070.5 8073.2 8171.4 8175.5 8272.4 615.7 638.3 640.4 649.3 665.1 3600.1 3751.5 3764.4 3820.0 3858.3 48359.5 48756.8 49904.5 49961.0 50253.0 44161.8 45674.5 45859.3 46167.3 47202.0 41331.0 41503.0 41845.4 41845.6 42384.0 6648.9 6662.3 6664.8 6671.2 6904.1 28311.6 28564.9 28669.3 28874.6 29370.3 33540.0 34373.3 36259.0 36594.3 36668.6 8463.7 8625.6 8821.0 8929.2 8992.5 10193.4 10219.4 10231.0 10253.7 10610.6 8941.7 9237.4 9282.4 9291.8 9307.2 9509.2 9512.0 9609.7 9971.6 10242.4 9216.6 9221.1 9288.8 9463.3 9710.8 8534.9 8639.2 8685.4 8740.3 8827.2 8333.3 8351.5 8478.2 8709.1 8740.9 15:12:19 INFO - PROCESS | 3150 | -------- Summary: end -------- 15:12:19 INFO - PROCESS | 3150 | 15:12:20 INFO - TEST-INFO | 3150: exit 0 15:12:20 INFO - TEST-OK | dromaeo_css | took 1113993ms 15:12:20 INFO - TEST-START | kraken 15:12:20 INFO - operating with platform_type : linux_ 15:12:20 INFO - Initialising browser for kraken test... 15:12:20 INFO - TEST-INFO | started process 3381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7zP0E5/profile http://localhost:56579/getInfo.html) 15:12:23 INFO - PROCESS | 3381 | 15:12:23 INFO - PROCESS | 3381 | (process:3447): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:12:24 INFO - PROCESS | 3381 | __metrics Screen width/height:1600/1200 15:12:24 INFO - PROCESS | 3381 | colorDepth:24 15:12:24 INFO - PROCESS | 3381 | Browser inner width/height: 1024/697 15:12:24 INFO - PROCESS | 3381 | __metrics 15:12:25 ERROR - PROCESS | 3381 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2937: TypeError: this.tabs is undefined 15:12:25 INFO - TEST-INFO | 3381: exit 0 15:12:25 INFO - Browser initialized. 15:12:25 INFO - Running cycle 1/1 for kraken test... 15:12:25 INFO - TEST-INFO | started process 3498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7zP0E5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:12:27 INFO - PROCESS | 3498 | 15:12:27 INFO - PROCESS | 3498 | (process:3559): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:12:37 INFO - PROCESS | 3498 | RSS: Main: 163729408 15:12:37 INFO - PROCESS | 3498 | 15:12:40 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-beat-detection) 15:12:41 INFO - PROCESS | 3498 | RSS: Main: 168333312 15:12:41 INFO - PROCESS | 3498 | 15:12:44 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-dft) 15:12:44 INFO - PROCESS | 3498 | RSS: Main: 168284160 15:12:44 INFO - PROCESS | 3498 | 15:12:47 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-fft) 15:12:48 INFO - PROCESS | 3498 | RSS: Main: 163909632 15:12:48 INFO - PROCESS | 3498 | 15:12:50 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56579/tests/kraken/driver.html?testName=audio-oscillator) 15:12:50 INFO - PROCESS | 3498 | RSS: Main: 164470784 15:12:50 INFO - PROCESS | 3498 | 15:12:53 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:53 INFO - PROCESS | 3498 | RSS: Main: 164085760 15:12:53 INFO - PROCESS | 3498 | 15:12:57 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:57 INFO - PROCESS | 3498 | RSS: Main: 164065280 15:12:57 INFO - PROCESS | 3498 | 15:13:01 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56579/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:02 INFO - PROCESS | 3498 | RSS: Main: 162734080 15:13:02 INFO - PROCESS | 3498 | 15:13:05 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56579/tests/kraken/driver.html?testName=json-parse-financial) 15:13:05 INFO - PROCESS | 3498 | RSS: Main: 163753984 15:13:05 INFO - PROCESS | 3498 | 15:13:07 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:08 INFO - PROCESS | 3498 | RSS: Main: 163840000 15:13:08 INFO - PROCESS | 3498 | 15:13:09 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:10 INFO - PROCESS | 3498 | RSS: Main: 163901440 15:13:10 INFO - PROCESS | 3498 | 15:13:12 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:13 INFO - PROCESS | 3498 | RSS: Main: 164143104 15:13:13 INFO - PROCESS | 3498 | 15:13:16 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:13:17 INFO - PROCESS | 3498 | RSS: Main: 163917824 15:13:17 INFO - PROCESS | 3498 | 15:13:19 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:13:20 INFO - PROCESS | 3498 | RSS: Main: 164315136 15:13:20 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | Cycle 1(1): loaded http://localhost:56579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56579/tests/kraken/driver.html?testName=ai-astar) 15:13:22 INFO - PROCESS | 3498 | RSS: Main: 165052416 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | __start_tp_report 15:13:22 INFO - PROCESS | 3498 | _x_x_mozilla_page_load 15:13:22 INFO - PROCESS | 3498 | _x_x_mozilla_page_load_details 15:13:22 INFO - PROCESS | 3498 | |i|pagename|runs| 15:13:22 INFO - PROCESS | 3498 | |0;ai-astar;113;118;113;117;119;116;111;115;118;117 15:13:22 INFO - PROCESS | 3498 | |1;audio-beat-detection;160;143;158;207;137;157;164;140;189;143 15:13:22 INFO - PROCESS | 3498 | |2;audio-dft;163;163;164;166;170;172;163;164;161;163 15:13:22 INFO - PROCESS | 3498 | |3;audio-fft;78;78;78;163;79;77;77;78;161;79 15:13:22 INFO - PROCESS | 3498 | |4;audio-oscillator;96;95;173;95;95;95;135;97;97;134 15:13:22 INFO - PROCESS | 3498 | |5;imaging-gaussian-blur;118;119;119;118;119;120;118;119;121;120 15:13:22 INFO - PROCESS | 3498 | |6;imaging-darkroom;148;151;150;150;149;149;150;150;149;172 15:13:22 INFO - PROCESS | 3498 | |7;imaging-desaturate;97;97;96;97;96;97;97;96;96;98 15:13:22 INFO - PROCESS | 3498 | |8;json-parse-financial;67;66;67;66;67;66;67;65;66;71 15:13:22 INFO - PROCESS | 3498 | |9;json-stringify-tinderbox;65;65;65;66;67;65;66;65;65;67 15:13:22 INFO - PROCESS | 3498 | |10;stanford-crypto-aes;85;87;91;83;89;91;90;90;147;85 15:13:22 INFO - PROCESS | 3498 | |11;stanford-crypto-ccm;145;139;142;144;140;152;144;147;159;141 15:13:22 INFO - PROCESS | 3498 | |12;stanford-crypto-pbkdf2;187;179;180;180;178;180;178;177;181;174 15:13:22 INFO - PROCESS | 3498 | |13;stanford-crypto-sha256-iterative;71;74;72;72;71;70;70;70;71;69 15:13:22 INFO - PROCESS | 3498 | __end_tp_report 15:13:22 INFO - PROCESS | 3498 | __start_cc_report 15:13:22 INFO - PROCESS | 3498 | _x_x_mozilla_cycle_collect,813 15:13:22 INFO - PROCESS | 3498 | __end_cc_report 15:13:22 INFO - PROCESS | 3498 | __startTimestamp1462832002621__endTimestamp 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | ------- Summary: start ------- 15:13:22 INFO - PROCESS | 3498 | Number of tests: 14 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#0] ai-astar Cycles:10 Average:115.70 Median:117.00 stddev:2.63 (2.2%) stddev-sans-first:2.60 15:13:22 INFO - PROCESS | 3498 | Values: 113.0 118.0 113.0 117.0 119.0 116.0 111.0 115.0 118.0 117.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#1] audio-beat-detection Cycles:10 Average:159.80 Median:159.00 stddev:22.57 (14.2%) stddev-sans-first:23.94 15:13:22 INFO - PROCESS | 3498 | Values: 160.0 143.0 158.0 207.0 137.0 157.0 164.0 140.0 189.0 143.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:3.48 (2.1%) stddev-sans-first:3.62 15:13:22 INFO - PROCESS | 3498 | Values: 163.0 163.0 164.0 166.0 170.0 172.0 163.0 164.0 161.0 163.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#3] audio-fft Cycles:10 Average:94.80 Median:78.00 stddev:35.43 (45.4%) stddev-sans-first:37.05 15:13:22 INFO - PROCESS | 3498 | Values: 78.0 78.0 78.0 163.0 79.0 77.0 77.0 78.0 161.0 79.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:95.00 stddev:27.06 (28.5%) stddev-sans-first:28.14 15:13:22 INFO - PROCESS | 3498 | Values: 96.0 95.0 173.0 95.0 95.0 95.0 135.0 97.0 97.0 134.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 15:13:22 INFO - PROCESS | 3498 | Values: 118.0 119.0 119.0 118.0 119.0 120.0 118.0 119.0 121.0 120.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:150.00 stddev:7.15 (4.8%) stddev-sans-first:7.45 15:13:22 INFO - PROCESS | 3498 | Values: 148.0 151.0 150.0 150.0 149.0 149.0 150.0 150.0 149.0 172.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:13:22 INFO - PROCESS | 3498 | Values: 97.0 97.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 98.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.72 15:13:22 INFO - PROCESS | 3498 | Values: 67.0 66.0 67.0 66.0 67.0 66.0 67.0 65.0 66.0 71.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 15:13:22 INFO - PROCESS | 3498 | Values: 65.0 65.0 65.0 66.0 67.0 65.0 66.0 65.0 65.0 67.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:89.50 stddev:18.90 (21.1%) stddev-sans-first:19.78 15:13:22 INFO - PROCESS | 3498 | Values: 85.0 87.0 91.0 83.0 89.0 91.0 90.0 90.0 147.0 85.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:144.50 stddev:6.11 (4.2%) stddev-sans-first:6.48 15:13:22 INFO - PROCESS | 3498 | Values: 145.0 139.0 142.0 144.0 140.0 152.0 144.0 147.0 159.0 141.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.00 stddev:3.34 (1.9%) stddev-sans-first:2.13 15:13:22 INFO - PROCESS | 3498 | Values: 187.0 179.0 180.0 180.0 178.0 180.0 178.0 177.0 181.0 174.0 15:13:22 INFO - PROCESS | 3498 | 15:13:22 INFO - PROCESS | 3498 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.41 (2.0%) stddev-sans-first:1.50 15:13:22 INFO - PROCESS | 3498 | Values: 71.0 74.0 72.0 72.0 71.0 70.0 70.0 70.0 71.0 69.0 15:13:22 INFO - PROCESS | 3498 | -------- Summary: end -------- 15:13:22 INFO - PROCESS | 3498 | 15:13:23 INFO - TEST-INFO | 3498: exit 0 15:13:23 INFO - TEST-OK | kraken | took 63264ms 15:13:23 INFO - SUITE-END | took 1177s 15:13:23 INFO - Completed test suite (00:19:37) 15:13:23 INFO - javascript benchmark 15:13:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.8679066046693, 2669.6395986541834, 2703.2025552462023, 2724.3733941193527, 2730.3037725380027, 4767.284907263912, 4791.568758811706, 4793.304970779235, 4820.5420485053955, 4874.6831455955335, 4632.467266264381, 4783.9760801196035, 4798.784054717537, 4842.934554398035, 4846.612271018319, 4411.64706823455, 4491.932621010687, 4539.251023581105, 4552.0668263006, 4594.264917613183, 4462.665300102489, 4527.615152712024, 4552.203364411232, 4589.701669391479, 4612.907741845161, 4318.3090705486975, 4359.411479450266, 4369.541198174209, 4376.606105450524, 4455.532169122261, 4399.824007039714, 4404.69167158299, 4404.889877753049, 4428.822847086113, 4452.799624016927, 4415.7350558966245, 4418.248897687401, 4421.535738747418, 4433.13553856998, 4445.599896009375, 4626.722396656178, 4674.0, 4684.3910291662205, 4685.461171965199, 4698.436187657503, 5052.191649336125, 5088.084144853925, 5092.770825312869, 5098.490150984909, 5125.794968201268, 5095.0574143783515, 5136.974315128437, 5148.742562871841, 5158.329417175743, 5159.406668233164, 4818.204996175627, 4860.659753817269, 4863.076015557032, 4865.5864251539015, 4892.2661600760175, 5246.895062098813, 5323.0, 5326.280952071498, 5342.519173274346, 5385.623006389594, 4932.8520144395725, 5058.317127187783, 5103.0049140418005, 5118.078745825713, 5129.204973229155, 5129.64092513528, 5133.307003554472, 5147.974260128675, 5186.896262074737, 5195.9740201298755, 4932.679375840559, 5013.949860501349, 5037.093323201859, 5079.111155547765, 5083.110455670243, 5001.074801161724, 5033.697978121324, 5053.393592768891, 5073.086844367976, 5107.438181799999, 4244.151169765997, 4325.0, 4347.282698354736, 4377.387165796791, 4427.29163333865, 3778.905527361838, 3827.4067519534515, 3834.1564855731694, 3839.788811615388, 3884.825182866721, 4356.150550642657, 4381.890452738707, 4428.933565996513, 4439.134368798053, 4445.844395446144, 4877.975610121997, 5108.693478391308, 5122.974385128051, 5186.170212766015, 5205.193195054772, 4398.296272596369, 4412.139632771643, 4429.0, 4432.31299148626, 4504.909901801946, 4685.718856868599, 4703.223968045234, 4707.741074240881, 4723.645726570521, 4762.523747625279, 4656.185167595657, 4703.412073490814, 4734.905301894012, 4735.905281894274, 4739.4075740532435, 5034.421041580119, 5040.974795126001, 5042.899142017066, 5042.974785126197, 5096.566791822588, 4713.528647135259, 4743.573078422958, 4748.406449193851, 4752.073345697694, 4787.497312782108, 5047.091523525801, 5066.290719299374, 5087.516685914832, 5104.1067813133295, 5111.156659151347, 5170.5346518813485, 5198.428172901054, 5207.140821764367, 5226.372835259793, 5253.080710875505, 4794.4486384064885, 4942.3080768693135, 5026.773795179152, 5035.118854200574, 5044.495550444926, 4763.333133361401, 4892.633052521004, 4938.135826230324, 4974.726390048582, 5076.949230507647, 4845.927311090266, 4890.633202509897, 4892.192788190051, 4898.167311556973, 4903.705777653352, 4818.4217893852965, 4974.154393752999, 5004.724740139327, 5019.3976722793495, 5037.571806396498, 4893.657443978887, 4956.677815941952, 4980.452150263541, 4982.302477653204, 4988.052270068675], "value": 4707.027246289901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.7605929450336, 572.4761842913734, 581.2182614383654, 593.5103539579845, 621.0776996160704, 34753.82623086884, 38112.618873811254, 38257.0, 38405.423918641245, 38770.41844372336, 39265.21469570607, 40192.59807401925, 40237.19525609486, 40266.7986660067, 40303.79848100763, 7714.228577142283, 7846.293833554979, 7886.6451009704415, 7905.090914544815, 7915.920840791576, 7789.532628042307, 7810.258025487569, 7840.372770178372, 7871.645775940096, 7872.252136047066, 7817.335526480228, 7833.64748586315, 7863.449558530905, 7897.842043159133, 7926.365890728756, 7804.0, 7821.882671759929, 7833.490823096509, 7855.371570274393, 7883.132855385903, 7683.385329173652, 7751.147373788879, 7780.494267872627, 7797.649105790197, 7802.921970780277, 36608.0, 36771.81614091939, 36859.0, 36944.0, 37053.629463705285, 3140.811551306929, 3182.458981973047, 3270.591176102987, 3289.0297362278184, 3476.739244556643, 28605.28486787826, 28828.855855720798, 28935.0, 29107.85446072756, 29503.262418439495, 3470.132466883279, 3471.409860323751, 3549.396602577568, 3550.5029295898594, 3594.622564630702, 233561.0, 234646.0, 235114.99999999828, 235814.0, 238041.0, 52338.73830630899, 52365.47634523606, 52462.0, 52549.7372513135, 52906.735466322425, 33983.4902476463, 35118.29763404769, 35418.46872296918, 37451.25097498035, 37721.245575088346, 13141.605751827461, 13233.0, 13236.602901912958, 13248.20510769357, 13307.933460332637, 9441.52792360393, 9496.43021418717, 9497.335186536877, 9525.5713492893, 9556.61773529051, 18392.724109138373, 18545.258189672262, 18605.441836744918, 18682.34611788581, 18747.90626046861, 7118.857622847514, 7205.92794072063, 7217.206107328189, 7244.746433874789, 7312.853742925112, 852.3905407633572, 981.788915383196, 986.7631768375538, 1004.633308842282, 1015.7663737340305, 25655.871720641277, 26725.0646227385, 26857.328566785596, 26996.730032699816, 27228.0, 957.4494665567327, 1025.553884060436, 1040.8646875906084, 1066.4774260612398, 1089.6760436070213, 14474.203918784568, 14665.48670796517, 14790.482333118289, 14999.475018374305, 15000.62498437526, 373105.0, 379579.0, 382014.0, 383005.0, 385477.0, 49223.26165107526, 49789.751051244515, 49802.501974980514, 49860.0, 49945.500544994815, 1261.4197469164103, 1269.8984081273477, 1281.4297637551388, 1283.6598301450124, 1286.2604002698486, 25718.87140564285, 26816.854651627433, 26982.0, 27266.591001134602, 27482.725172748018, 42235.577644223165, 42370.576294236664, 42389.36415953701, 42768.936950989606, 42832.0, 306120.0, 315488.0, 315767.52697419113, 315830.0, 317012.0, 25200.117995870056, 25779.226623201335, 25802.0, 25811.612825808003, 25827.225183244533, 40917.59082409138, 42634.0, 42723.5727642732, 43057.354139687304, 43473.130537389705, 34756.65243347635, 36040.0, 36457.817710912335, 36480.81759591185, 36588.634113658525, 35594.64405355913, 36122.63877361193, 36480.63519364772, 36519.81740091283, 37111.25777484489, 35223.29553408866, 35527.64472355243, 35934.8203258982, 36464.0, 36529.63470365262, 30219.0, 31865.840670796497, 32277.838610806797, 32407.0, 32419.513707293936, 24456.0, 27321.72678273192, 27828.0, 28015.859920700266, 28132.43735125245], "value": 17297.38932595092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.1848496338129, 369.83172656441315, 373.5629313702967, 383.8656470235416, 391.67882336484075, 16006.119663418522, 16150.273237704303, 17295.91352043238, 17432.38986635468, 17475.038872861987, 16586.25361858716, 16867.746983795223, 17867.374641887538, 17928.103594820273, 17931.91034044828, 4799.184138696412, 5130.050940576006, 5172.40517340505, 5181.689098654074, 5186.299849520305, 4905.3132561441425, 5060.6963582185, 5141.614378921578, 5145.305383773199, 5148.124818780816, 5078.873028174288, 5083.212102124176, 5087.567556757662, 5098.388193416795, 5128.358955130609, 4835.298881662175, 4872.488388719186, 4934.901301973959, 5097.158968770167, 5115.335006449138, 4569.497355290949, 4587.587117159472, 4590.472095709003, 4594.333821595883, 4614.330922016289, 15275.923620381938, 18527.2589096436, 20763.792362076336, 21124.15503379863, 21158.576828463498, 2009.346962237264, 2023.908924098419, 2031.1570698160247, 2046.6009128220003, 2539.733328000552, 13329.533466328729, 13831.239281839595, 13834.446622135103, 14084.577462676136, 14325.64185895361, 1735.0, 1740.6779745747078, 1795.3805936951862, 1802.4502526729343, 1873.0728289496785, 65413.0, 66369.01785892814, 67980.3201967979, 68642.65678671574, 69209.65395172992, 8317.126701696356, 9137.223336016381, 9159.358844880795, 9374.484403357745, 9498.382605130644, 12411.441485133191, 12430.689232769073, 12465.626031219077, 12480.875191248153, 12505.93747031259, 6627.536072474977, 6781.966090169518, 6813.046173535709, 6831.931680683129, 6890.689918953659, 6576.80269591913, 6584.814733347947, 6609.20689517261, 6657.068010478537, 6668.83327916806, 3893.1507533921163, 3962.5443074046275, 3971.980140099281, 3982.6216509431556, 3992.121733218687, 1837.9816201838078, 1865.6268746250805, 1902.781180164271, 1971.9211231550578, 1982.4548249231577, 793.5040599625235, 845.0577605969423, 895.7402353317595, 936.3679516326589, 956.3735753081743, 16461.25924333408, 17095.316187352615, 17290.481285561455, 17311.468238779467, 17716.557086072695, 874.8206617643368, 876.5573385440312, 883.726044926075, 915.9358844880794, 933.5658918602883, 9607.711768646952, 9850.0, 9888.555015024342, 9994.300398972002, 10021.198304135653, 388502.0, 390063.0, 403216.0, 403420.0, 412507.0, 80768.0, 82169.0, 83495.582522087, 83703.58148209342, 83972.58013709892, 937.6577549194632, 948.4167237149104, 951.8762560867043, 962.7208109648124, 964.5322018820866, 15039.398424063353, 15118.773218401513, 15171.772423413437, 15468.690626187188, 15681.372745090068, 35181.0, 35755.821220893726, 35863.82068089747, 36004.0, 36257.27485450223, 46321.305180421645, 48901.75549122231, 49592.256116157565, 49970.0, 50087.24869127039, 7685.615719214129, 7687.154413014452, 7718.807029824299, 7835.725749598737, 7869.606519673879, 8660.047394786443, 10804.67585972422, 11619.477123529292, 11710.414479276173, 11761.705957351134, 9965.50172491358, 10036.849447258443, 10450.42522661261, 10624.734381640212, 10630.681079567625, 10276.588936442458, 10312.123469505175, 10453.006964338376, 10520.947395262974, 10739.087177589992, 10361.171106311327, 10556.155507559222, 10660.200484963814, 10660.413677247825, 10834.241603088023, 7791.571463569331, 7844.882326764989, 7921.920780792118, 8069.83860322802, 8106.959465202636, 9635.710928672152, 10546.20903432261, 10593.576256949944, 10730.087942524973, 10772.784544308914], "value": 8210.157756689767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.6195608163835, 1461.3570029187156, 1568.1845440371007, 1735.739639054141, 1736.3054778088772, 6332.683365831702, 6970.477214208936, 7040.29597040297, 7250.274972502753, 7284.672189751461, 7126.32299931507, 7414.518056326335, 7416.888746668804, 7432.331090201881, 7444.143923448805, 2137.625915464795, 2175.4778853075227, 2178.16140785797, 2178.553396553703, 2181.792729690677, 2126.26643807886, 2133.221374198422, 2152.117631770974, 2154.2244791874914, 2172.630652789022, 2143.142742902836, 2158.5467051919118, 2173.0547211962767, 2175.967360489594, 2177.68423578581, 2087.530305681217, 2087.8642888212294, 2094.371688493461, 2097.0039231365054, 2103.7265155529835, 2045.734054572896, 2082.937511874646, 2091.393495886191, 2092.4350425385214, 2095.98952005239, 7338.0, 7469.2904174103915, 7496.212897645723, 7496.8125796854965, 7517.135529414078, 4272.060146767706, 4419.204543182226, 4450.777461126931, 4453.621442177418, 4456.064226512404, 2834.433113377312, 2844.48799216141, 3012.186709588421, 3020.652624948137, 3021.2748940254182, 873.5937788928179, 919.4069824962928, 933.2440723014312, 945.3477100800426, 958.8226178156993, 9251.0, 9366.67216647414, 9387.295952803499, 9453.763655908588, 9669.854952175723, 4015.8393664253686, 4033.878983630496, 4035.7174997749876, 4061.411095391211, 4137.689673274516, 8134.105248422668, 8312.127226641236, 8319.916800832036, 8459.238668519863, 8515.57422128891, 4251.574842515785, 4281.593248641374, 4404.757738324423, 4443.466783985878, 4457.955420445754, 3489.3195826813526, 3763.8682646107254, 3926.5680775114715, 4079.7756123412905, 4106.527749308868, 3533.2756784859043, 3568.892933212008, 3590.353736327434, 3619.8371073301237, 3717.070732316921, 1199.9280043197436, 1202.4649031181216, 1203.0556013529338, 1204.7590481903653, 1215.9939200303943, 661.798151563768, 766.501773847004, 819.647551552826, 837.3175861672718, 865.8268346330759, 4839.637027222972, 5027.069992051483, 5047.899042019212, 5099.031184075014, 5119.564836988898, 867.5141920524401, 874.7944233105216, 877.9868301975475, 894.5035505294494, 922.8154369126202, 3427.4344733118755, 3452.861885524551, 3469.826508674556, 3505.544279243682, 3538.4515400113023, 8761.474311541328, 8886.289096872364, 9084.364094513321, 9170.037146099563, 9205.263578913671, 8985.775355616031, 9005.774855628531, 9090.500022498825, 9094.18152366277, 9113.589888455035, 6856.211535673461, 7111.502194846415, 7119.7864064079195, 7133.82165445868, 7170.749023784142, 4880.0, 4886.218205087169, 4947.406311242674, 5052.494750524918, 5061.6962982221185, 8033.517988920684, 8364.247217750188, 8479.533625650649, 8520.61657225414, 8597.699080532151, 8528.701495447629, 8542.82914341722, 8597.742067737978, 8714.91285087141, 8730.17063378978, 5441.727913604224, 5874.970625146847, 6018.518518518596, 6104.38956104386, 6242.906356404748, 7145.82135446618, 7165.319294666998, 7205.423566114803, 7238.6380680964685, 7249.275072492708, 6339.080833279057, 6459.321771213955, 6514.0880276760345, 6621.238557565942, 6783.423409010092, 6568.6537639539765, 6580.1116849224745, 6589.835254118685, 6610.9669451652435, 6657.167854018247, 6037.426444487766, 6063.363346848694, 6123.2652081750475, 6131.601445906002, 6162.983107787165, 4464.55354464564, 4492.955070449254, 4560.270356742905, 4625.676202665781, 4690.554397332248, 4589.541045895384, 4614.4693360264, 4648.604868586208, 4699.812007519798, 4713.835015774432], "value": 3997.9988873011966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.47218603536817, 311.76150245062524, 318.442725230846, 320.94062598419293, 322.72890771751725, 4702.9529704702945, 4795.59237464815, 4823.541763532463, 4903.215485522322, 4910.042541704364, 4794.448638406576, 4800.927986080212, 4836.661433699643, 4838.927416088753, 4864.805407783693, 3785.2429514097153, 3812.8284227209842, 3821.216650586623, 3830.578636349999, 3831.8275677594575, 3713.3501637213517, 3809.314323421783, 3845.8846234613006, 3849.9027777083397, 3860.4595356650093, 3757.3800322946818, 3763.7929913854728, 3779.829907654162, 3781.0, 3787.185755062661, 3743.9625603743884, 3772.207836354355, 3781.111438811877, 3785.470034195215, 3785.5268091488565, 3388.1868351595685, 3392.23674673199, 3394.251960240478, 3398.4732366483236, 3422.281320922609, 4412.536683648203, 4693.460252071021, 4716.716996980193, 4749.596284315838, 4750.954789946206, 4197.433346498245, 4200.15996800638, 4204.369344598304, 4270.295401258789, 4278.935815962763, 5016.523430274155, 5033.597312215014, 5050.217216331474, 5055.828941123587, 5105.085592902661, 3621.4567814827988, 3627.1838836261895, 3635.4183330666965, 3641.326354624403, 3671.971847882597, 4927.43334516528, 5318.946810531884, 5321.813736519242, 5329.786808527654, 5364.946350536523, 3646.890593282206, 3682.4476328550395, 3701.9259614808093, 3711.0, 3720.2187540616233, 3745.5318085239346, 3747.362948298796, 3753.0804952786743, 3766.114962983697, 3767.7550959187565, 4069.1861627674584, 4229.703920725581, 4255.8084886180195, 4277.1873344064525, 4286.657067434598, 5020.196768517093, 5073.416557095908, 5092.9236061459105, 5096.770645320969, 5104.795808167706, 1187.8396416483838, 1209.1535924852637, 1216.5583783216916, 1246.1401632873287, 1246.3456685240321, 845.6955496021427, 854.1842540373927, 864.4208380385157, 865.5672163918041, 877.859542473214, 4156.293430116887, 4167.562405947392, 4168.979155104265, 4196.979015104966, 4236.533981262059, 4942.481039490802, 4972.403311602631, 4977.552020318189, 4979.601631869442, 5032.924506132411, 4174.749515029108, 4207.495100587949, 4217.957820421818, 4238.851640192578, 4243.787810609457, 2467.3338198686256, 2627.2249686342575, 2641.543364670836, 2676.0, 2692.3269182704325, 4738.431388233365, 4768.594669453066, 4782.206672497813, 4783.942904551007, 4807.423109226846, 5164.32863727713, 5167.276581278624, 5172.844814655567, 5174.663646862942, 5229.607779416559, 4577.473590537064, 4744.857654270378, 4750.976245118753, 4775.116603428377, 4776.2119250324, 5025.572826309804, 5029.170186919117, 5049.444561098203, 5105.417320630617, 5145.45972672864, 4965.900681986413, 4971.414864270631, 4992.525710057539, 5012.77442515095, 5016.272640467038, 4619.69971951822, 4960.429550601727, 4966.528179822911, 4971.825986090469, 4976.32819569368, 3636.7999760013454, 3677.9632203678693, 3710.128119891769, 3710.666040056408, 3719.367707489679, 5012.223105418666, 5263.394709608444, 5269.841904742864, 5277.788888444419, 5341.519263266325, 4932.482089380564, 5099.796008159632, 5102.260172274925, 5103.974480127576, 5106.183010718416, 5045.470225626404, 5086.669366491166, 5116.7441627917715, 5138.614603904797, 5144.536991670768, 4846.321514987834, 4997.9750101249265, 5022.438556336368, 5049.419316778617, 5053.448008755555, 5105.6426050177615, 5105.693658380509, 5122.974385128051, 5137.280780690631, 5147.0, 4998.950010499849, 5020.799168033238, 5047.712833227651, 5066.265391518283, 5072.300779238996], "value": 3788.413207395004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.4205977277951, 742.5952855693643, 748.943829212809, 788.9171636978116, 794.6463823598501, 12638.936805315972, 13572.185668859875, 13590.388432520536, 13987.0, 14036.298185090756, 13851.376688049037, 13855.653608659763, 13939.651508712288, 13948.930255348734, 13988.580342589714, 653.2194028136379, 861.2378045429792, 870.2950610005884, 871.834351473218, 872.4198408058634, 845.4039901869198, 881.7002219245455, 882.4484697064335, 884.385352180235, 888.8089060851947, 899.6356475627381, 909.9317551183655, 913.6071489259616, 916.839553078212, 917.3899356927635, 901.8782464367292, 903.8824952756165, 904.1184844776357, 906.9818603627923, 911.7173676160412, 670.0384947600161, 671.1208317104608, 671.8387586979138, 673.0409166937095, 676.6177109932872, 12557.246565206116, 12627.684307892285, 12692.555760548428, 12701.555445559361, 12732.363381830872, 10914.945425272823, 11715.472803723853, 12012.0, 12039.217450865754, 12281.69295767613, 9658.565364558612, 9686.70939871805, 9725.756856078584, 9955.402675839472, 9982.9500852496, 3232.143481977278, 3262.8531716072835, 3318.1704573856537, 3365.4615261558033, 3371.865125394981, 42878.78560607208, 43148.137037259396, 43246.35130473045, 43314.566854331366, 43777.0, 9734.464604446823, 9867.950660246654, 9983.700488985342, 10060.446675432922, 10073.395596264247, 17005.744913826304, 17110.0589467578, 17131.91434042822, 17262.913685431493, 17366.39217627377, 6453.903191452132, 6517.674116294166, 6560.639164845884, 6621.768238111643, 6761.0872532208505, 3570.0, 3584.0143960411096, 3588.7667301625834, 3621.456781482746, 3705.4071348584635, 2881.423715256957, 2973.167513096293, 3007.65411977621, 3028.37918226763, 3033.2568520712566, 532.7629402968807, 538.4158188365667, 544.599719206383, 552.4668694709625, 555.0148486436607, 626.8056902360283, 641.5541198866742, 649.6719156825773, 653.6176336842905, 659.7525927777084, 8070.515769053758, 8073.233042860918, 8171.428000040059, 8175.48049528543, 8272.37957153216, 615.7444660465947, 638.3265654734207, 640.4044238857814, 649.2533586375706, 665.1423820411572, 3600.1179710970455, 3751.531058617673, 3764.378877485184, 3820.0, 3858.324793161242, 48359.5164048355, 48756.756216218695, 49904.50095499071, 49961.0, 50253.0, 44161.77919110384, 45674.543254567696, 45859.31211031837, 46167.30749038767, 47202.0, 41331.0, 41503.0, 41845.37231941523, 41845.58154418417, 42384.0, 6648.90026649591, 6662.267150613526, 6664.766733164316, 6671.232808227116, 6904.102466679299, 28311.575326370534, 28564.857175713987, 28669.28326791847, 28874.566881497216, 29370.265743355732, 33539.993800186036, 34373.312533748685, 36259.0, 36594.26811463702, 36668.63331366759, 8463.74608761738, 8625.568721564023, 8820.955895220482, 8929.241014513838, 8992.505412202392, 10193.439360835226, 10219.386836789816, 10231.0, 10253.743656408351, 10610.628627997983, 8941.687040953795, 9237.445753254557, 9282.443053416817, 9291.767705807139, 9307.162355388047, 9509.239260858976, 9512.0, 9609.711708648752, 9971.551280192554, 10242.436665983443, 9216.585253663467, 9221.123993220634, 9288.767780805534, 9463.337566370288, 9710.805783884423, 8534.914650853412, 8639.199259752992, 8685.435446695945, 8740.34447416459, 8827.16141966512, 8333.250007499355, 8351.498910065415, 8478.23695867375, 8709.077827077648, 8740.868886966573], "value": 5833.924071650191, "unit": "score"}], "name": "dromaeo_css", "value": 6240.67638649038, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 113.0, 117.0, 119.0, 116.0, 111.0, 115.0, 118.0, 117.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 143.0, 158.0, 207.0, 137.0, 157.0, 164.0, 140.0, 189.0, 143.0], "value": 159.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 166.0, 170.0, 172.0, 163.0, 164.0, 161.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 163.0, 79.0, 77.0, 77.0, 78.0, 161.0, 79.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 173.0, 95.0, 95.0, 95.0, 135.0, 97.0, 97.0, 134.0], "value": 111.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 118.0, 119.0, 120.0, 118.0, 119.0, 121.0, 120.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 149.0, 172.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 98.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 65.0, 66.0, 71.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 91.0, 83.0, 89.0, 91.0, 90.0, 90.0, 147.0, 85.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 142.0, 144.0, 140.0, 152.0, 144.0, 147.0, 159.0, 141.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 179.0, 180.0, 180.0, 178.0, 180.0, 178.0, 177.0, 181.0, 174.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 72.0, 72.0, 71.0, 70.0, 70.0, 70.0, 71.0, 69.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1635.8999999999999, "alertThreshold": 2.0}]} 15:13:23 INFO - Return code: 0 15:13:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:13:23 ERROR - # TBPL SUCCESS # 15:13:23 INFO - Running post-action listener: _resource_record_post_action 15:13:23 INFO - ##### 15:13:23 INFO - ##### Finished run-tests step (success) 15:13:23 INFO - ##### 15:13:23 INFO - Running post-run listener: _resource_record_post_run 15:13:24 INFO - Total resource usage - Wall time: 1194s; CPU: 26.0%; Read bytes: 4096; Write bytes: 526213120; Read time: 20; Write time: 447724 15:13:24 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 238866432; Read time: 0; Write time: 264048 15:13:24 INFO - run-tests - Wall time: 1179s; CPU: 26.0%; Read bytes: 4096; Write bytes: 287346688; Read time: 20; Write time: 183676 15:13:24 INFO - Running post-run listener: _upload_blobber_files 15:13:24 INFO - Blob upload gear active. 15:13:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:13:24 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 15:13:24 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'] 15:13:24 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 15:13:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:13:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:13:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:13:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:26 INFO - (blobuploader) - INFO - Done attempting. 15:13:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:13:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:13:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:13:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:13:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:13:26 INFO - (blobuploader) - INFO - Done attempting. 15:13:26 INFO - (blobuploader) - INFO - Iteration through files over. 15:13:26 INFO - Return code: 0 15:13:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:13:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:13:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e44e8e3a33ae705b4596e168c820f187f4e374a0336566e7222f73f1a5d72d16ddb056c2746f8735c4ece8da6e928346b84f136bab5fc016b6be53aac8e27fb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f1bef30b7f13e4d8d246aa03ae4dcffc481165827aea7d74aa0d683cbf45a806ee78bd171ae95ea9579d6142a0e16d8c4eb3358389f273391363ebba215cf9"} 15:13:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:13:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:13:26 INFO - Contents: 15:13:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e44e8e3a33ae705b4596e168c820f187f4e374a0336566e7222f73f1a5d72d16ddb056c2746f8735c4ece8da6e928346b84f136bab5fc016b6be53aac8e27fb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f1bef30b7f13e4d8d246aa03ae4dcffc481165827aea7d74aa0d683cbf45a806ee78bd171ae95ea9579d6142a0e16d8c4eb3358389f273391363ebba215cf9"} 15:13:26 INFO - Running post-run listener: copy_logs_to_upload_dir 15:13:26 INFO - Copying logs to upload dir... 15:13:26 INFO - mkdir: /builds/slave/test/build/upload/logs 15:13:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.607142 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-05-09 15:13:27.045711) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:13:27.048818) ========= 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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 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/e44e8e3a33ae705b4596e168c820f187f4e374a0336566e7222f73f1a5d72d16ddb056c2746f8735c4ece8da6e928346b84f136bab5fc016b6be53aac8e27fb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f1bef30b7f13e4d8d246aa03ae4dcffc481165827aea7d74aa0d683cbf45a806ee78bd171ae95ea9579d6142a0e16d8c4eb3358389f273391363ebba215cf9"} build_url:https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005310 build_url: 'https://queue.taskcluster.net/v1/task/VOT3wMg5R9a2w2_sWQ9QfQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e44e8e3a33ae705b4596e168c820f187f4e374a0336566e7222f73f1a5d72d16ddb056c2746f8735c4ece8da6e928346b84f136bab5fc016b6be53aac8e27fb1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/83f1bef30b7f13e4d8d246aa03ae4dcffc481165827aea7d74aa0d683cbf45a806ee78bd171ae95ea9579d6142a0e16d8c4eb3358389f273391363ebba215cf9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 15:13:27.062335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:13:27.062646) ========= 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=db0483c52d987ecb441a263b000001ad-1462830773.889352-948806318 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 15:13:27.108961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:13:27.109260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 15:13:27.109549) ========= ========= Total master_lag: 0.45 =========