builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1462581522.57 results: success (0) buildid: 20160506163539 builduid: 4735616e08b340879777bbb5a7dcc9bc revision: 738ec20418cc728910419aa60f98ae62b429facf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.567425) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.568391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.568871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.586981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.587596) ========= 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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 17:38:42-- 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% 63.7M=0s 2016-05-06 17:38:42 (63.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.712110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.712903) ========= 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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018576 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:42.764981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 17:38:42.765498) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 738ec20418cc728910419aa60f98ae62b429facf --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 738ec20418cc728910419aa60f98ae62b429facf --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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 17:38:42,890 truncating revision to first 12 chars 2016-05-06 17:38:42,890 Setting DEBUG logging. 2016-05-06 17:38:42,890 attempt 1/10 2016-05-06 17:38:42,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/738ec20418cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 17:38:43,894 unpacking tar archive at: fx-team-738ec20418cc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.252595 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-06 17:38:44.035605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:44.035991) ========= script_repo_revision: 738ec20418cc728910419aa60f98ae62b429facf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:44.036471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:44.036777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 17:38:44.047578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-06 17:38:44.048074) ========= /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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:38:44 INFO - MultiFileLogger online at 20160506 17:38:44 in /builds/slave/test 17:38:44 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 17:38:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:38:44 INFO - {'append_to_log': False, 17:38:44 INFO - 'base_work_dir': '/builds/slave/test', 17:38:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:38:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:38:44 INFO - 'branch': 'Fx-Team-Non-PGO', 17:38:44 INFO - 'buildbot_json_path': 'buildprops.json', 17:38:44 INFO - 'config_files': ('talos/linux_config.py',), 17:38:44 INFO - 'default_actions': ('clobber', 17:38:44 INFO - 'read-buildbot-config', 17:38:44 INFO - 'download-and-extract', 17:38:44 INFO - 'populate-webroot', 17:38:44 INFO - 'create-virtualenv', 17:38:44 INFO - 'install', 17:38:44 INFO - 'run-tests'), 17:38:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:38:44 INFO - 'download_minidump_stackwalk': True, 17:38:44 INFO - 'download_symbols': 'ondemand', 17:38:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:38:44 INFO - 'tooltool.py': '/tools/tooltool.py', 17:38:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:38:44 INFO - '/tools/misc-python/virtualenv.py')}, 17:38:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:38:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:38:44 INFO - 'installer_path': 'installer.exe', 17:38:44 INFO - 'log_level': 'info', 17:38:44 INFO - 'log_name': 'talos', 17:38:44 INFO - 'log_to_console': True, 17:38:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:38:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:38:44 INFO - 'opt_config_files': (), 17:38:44 INFO - 'pip_index': False, 17:38:44 INFO - 'sps_profile': False, 17:38:44 INFO - 'sps_profile_interval': 0, 17:38:44 INFO - 'suite': 'dromaeojs-e10s', 17:38:44 INFO - 'system_bits': '32', 17:38:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:38:44 INFO - 'title': 'talos-linux64-ix-043', 17:38:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:38:44 INFO - 'use_talos_json': True, 17:38:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:38:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:38:44 INFO - 'work_dir': 'build'} 17:38:44 INFO - ##### 17:38:44 INFO - ##### Running clobber step. 17:38:44 INFO - ##### 17:38:44 INFO - Running pre-action listener: _resource_record_pre_action 17:38:44 INFO - Running main action method: clobber 17:38:44 INFO - rmtree: /builds/slave/test/build 17:38:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:38:44 INFO - Running post-action listener: _resource_record_post_action 17:38:44 INFO - ##### 17:38:44 INFO - ##### Finished clobber step (success) 17:38:44 INFO - ##### 17:38:44 INFO - ##### 17:38:44 INFO - ##### Running read-buildbot-config step. 17:38:44 INFO - ##### 17:38:44 INFO - Running pre-action listener: _resource_record_pre_action 17:38:44 INFO - Running main action method: read_buildbot_config 17:38:44 INFO - Using buildbot properties: 17:38:44 INFO - { 17:38:44 INFO - "project": "", 17:38:44 INFO - "product": "firefox", 17:38:44 INFO - "script_repo_revision": "production", 17:38:44 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:38:44 INFO - "repository": "", 17:38:44 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:38:44 INFO - "buildid": "20160506163539", 17:38:44 INFO - "pgo_build": "False", 17:38:44 INFO - "basedir": "/builds/slave/test", 17:38:44 INFO - "buildnumber": 1259, 17:38:44 INFO - "slavename": "talos-linux64-ix-043", 17:38:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:38:44 INFO - "platform": "ubuntu64_hw", 17:38:44 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:38:44 INFO - "branch": "fx-team", 17:38:44 INFO - "repo_path": "integration/fx-team", 17:38:44 INFO - "revision": "738ec20418cc728910419aa60f98ae62b429facf", 17:38:44 INFO - "stage_platform": "linux64", 17:38:44 INFO - "builduid": "4735616e08b340879777bbb5a7dcc9bc", 17:38:44 INFO - "slavebuilddir": "test" 17:38:44 INFO - } 17:38:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:38:44 INFO - Running post-action listener: _resource_record_post_action 17:38:44 INFO - ##### 17:38:44 INFO - ##### Finished read-buildbot-config step (success) 17:38:44 INFO - ##### 17:38:44 INFO - ##### 17:38:44 INFO - ##### Running download-and-extract step. 17:38:44 INFO - ##### 17:38:44 INFO - Running pre-action listener: _resource_record_pre_action 17:38:44 INFO - Running main action method: download_and_extract 17:38:44 INFO - mkdir: /builds/slave/test/build/tests 17:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:44 INFO - https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:45 INFO - Downloaded 1361 bytes. 17:38:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:38:45 INFO - Using the following test package requirements: 17:38:45 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:38:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:38:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:38:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'jsshell-linux-x86_64.zip'], 17:38:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:38:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:38:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:38:45 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:38:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:38:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:38:45 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:38:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:38: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')]} 17:38:45 INFO - https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:46 INFO - Downloaded 22321369 bytes. 17:38:46 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'] 17:38:46 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 17:38:47 INFO - Return code: 0 17:38:47 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 17:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:47 INFO - https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:49 INFO - Downloaded 22321369 bytes. 17:38:49 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'] 17:38:49 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 17:38:50 INFO - Return code: 0 17:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:50 INFO - https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:51 INFO - Downloaded 10840152 bytes. 17:38:51 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'] 17:38:51 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 17:38:51 INFO - Return code: 0 17:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:38:51 INFO - https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:38:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:38:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:38:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cY95jxuvS3et5mgvpMpgqQ/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 17:38:53 INFO - Downloaded 54840780 bytes. 17:38:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:38:53 INFO - mkdir: /builds/slave/test/properties 17:38:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:53 INFO - Contents: 17:38:53 INFO - build_url:https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:38:54 INFO - Running post-action listener: _resource_record_post_action 17:38:54 INFO - Running post-action listener: set_extra_try_arguments 17:38:54 INFO - ##### 17:38:54 INFO - ##### Finished download-and-extract step (success) 17:38:54 INFO - ##### 17:38:54 INFO - ##### 17:38:54 INFO - ##### Running populate-webroot step. 17:38:54 INFO - ##### 17:38:54 INFO - Running pre-action listener: _resource_record_pre_action 17:38:54 INFO - Running main action method: populate_webroot 17:38:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:54 INFO - '--tppagecycles', 17:38:54 INFO - '7'], 17:38:54 INFO - 'tests': ['tsvgm']}}, 17:38:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['damp', 'tps']}, 17:38:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'tests': ['damp', 'tps']}, 17:38:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['dromaeo_dom']}, 17:38:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['a11yr', 17:38:54 INFO - 'ts_paint', 17:38:54 INFO - 'tpaint', 17:38:54 INFO - 'sessionrestore', 17:38:54 INFO - 'sessionrestore_no_auto_restore', 17:38:54 INFO - 'tabpaint']}, 17:38:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['tsvgx', 17:38:54 INFO - 'tsvgr_opacity', 17:38:54 INFO - 'tart', 17:38:54 INFO - 'tscrollx', 17:38:54 INFO - 'cart']}, 17:38:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:54 INFO - 'tsvgr_opacity', 17:38:54 INFO - 'tart', 17:38:54 INFO - 'tscrollx', 17:38:54 INFO - 'cart']}, 17:38:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'talos_options': ['--disable-e10s'], 17:38:54 INFO - 'tests': ['tp5o']}, 17:38:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'tests': ['tp5o']}, 17:38:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'talos_options': ['--disable-e10s', 17:38:54 INFO - '--xperf_path', 17:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:54 INFO - 'tests': ['tp5n']}, 17:38:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:38:54 INFO - 'talos_options': ['--xperf_path', 17:38:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:54 INFO - 'tests': ['tp5n']}}, 17:38:54 INFO - 'talos.zip': {'path': '', 17:38:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:54 INFO - Running post-action listener: _resource_record_post_action 17:38:54 INFO - ##### 17:38:54 INFO - ##### Finished populate-webroot step (success) 17:38:54 INFO - ##### 17:38:54 INFO - ##### 17:38:54 INFO - ##### Running create-virtualenv step. 17:38:54 INFO - ##### 17:38:54 INFO - Running pre-action listener: _resource_record_pre_action 17:38:54 INFO - Running main action method: create_virtualenv 17:38:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:54 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 17:38:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:54 INFO - Using real prefix '/usr' 17:38:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:56 INFO - Installing pip.................done. 17:38:56 INFO - Return code: 0 17:38:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:56 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')]} 17:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:56 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')]} 17:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:56 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:38:56 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 17:38:56 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 17:38:56 INFO - Using env: {'DISPLAY': ':0', 17:38:56 INFO - 'HOME': '/home/cltbld', 17:38:56 INFO - 'LANG': 'en_US.UTF-8', 17:38:56 INFO - 'LANGUAGE': 'en_US:en', 17:38:56 INFO - 'LOGNAME': 'cltbld', 17:38:56 INFO - 'MAIL': '/var/mail/cltbld', 17:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:56 INFO - 'MOZ_NO_REMOTE': '1', 17:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:56 INFO - 'NO_EM_RESTART': '1', 17:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:56 INFO - 'PWD': '/builds/slave/test', 17:38:56 INFO - 'SHELL': '/bin/bash', 17:38:56 INFO - 'SHLVL': '1', 17:38:56 INFO - 'TERM': 'linux', 17:38:56 INFO - 'TMOUT': '86400', 17:38:56 INFO - 'USER': 'cltbld', 17:38:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:56 INFO - '_': '/tools/buildbot/bin/python'} 17:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:56 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 17:38:56 INFO - Cleaning up... 17:38:56 INFO - Return code: 0 17:38:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:38:56 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')]} 17:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:56 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')]} 17:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:56 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:38:56 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 17:38:56 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 17:38:56 INFO - Using env: {'DISPLAY': ':0', 17:38:56 INFO - 'HOME': '/home/cltbld', 17:38:56 INFO - 'LANG': 'en_US.UTF-8', 17:38:56 INFO - 'LANGUAGE': 'en_US:en', 17:38:56 INFO - 'LOGNAME': 'cltbld', 17:38:56 INFO - 'MAIL': '/var/mail/cltbld', 17:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:56 INFO - 'MOZ_NO_REMOTE': '1', 17:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:56 INFO - 'NO_EM_RESTART': '1', 17:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:56 INFO - 'PWD': '/builds/slave/test', 17:38:56 INFO - 'SHELL': '/bin/bash', 17:38:56 INFO - 'SHLVL': '1', 17:38:56 INFO - 'TERM': 'linux', 17:38:56 INFO - 'TMOUT': '86400', 17:38:56 INFO - 'USER': 'cltbld', 17:38:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:56 INFO - '_': '/tools/buildbot/bin/python'} 17:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:57 INFO - Downloading/unpacking psutil>=0.7.1 17:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:57 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 17:38:57 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 17:38:57 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 17:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:57 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 17:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:59 INFO - Installing collected packages: psutil 17:38:59 INFO - Running setup.py install for psutil 17:38:59 INFO - building 'psutil._psutil_linux' extension 17:38:59 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 17:38:59 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 17:38:59 INFO - building 'psutil._psutil_posix' extension 17:38:59 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 17:38:59 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 17:38:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:59 INFO - Successfully installed psutil 17:38:59 INFO - Cleaning up... 17:38:59 INFO - Return code: 0 17:38:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:38:59 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')]} 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:59 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')]} 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:59 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:38:59 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 17:38:59 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 17:38:59 INFO - Using env: {'DISPLAY': ':0', 17:38:59 INFO - 'HOME': '/home/cltbld', 17:38:59 INFO - 'LANG': 'en_US.UTF-8', 17:38:59 INFO - 'LANGUAGE': 'en_US:en', 17:38:59 INFO - 'LOGNAME': 'cltbld', 17:38:59 INFO - 'MAIL': '/var/mail/cltbld', 17:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:59 INFO - 'MOZ_NO_REMOTE': '1', 17:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:38:59 INFO - 'NO_EM_RESTART': '1', 17:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:59 INFO - 'PWD': '/builds/slave/test', 17:38:59 INFO - 'SHELL': '/bin/bash', 17:38:59 INFO - 'SHLVL': '1', 17:38:59 INFO - 'TERM': 'linux', 17:38:59 INFO - 'TMOUT': '86400', 17:38:59 INFO - 'USER': 'cltbld', 17:38:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:59 INFO - '_': '/tools/buildbot/bin/python'} 17:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:39:01 INFO - Installing collected packages: mozsystemmonitor 17:39:01 INFO - Running setup.py install for mozsystemmonitor 17:39:01 INFO - Successfully installed mozsystemmonitor 17:39:01 INFO - Cleaning up... 17:39:01 INFO - Return code: 0 17:39:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:39:01 INFO - Using env: {'DISPLAY': ':0', 17:39:01 INFO - 'HOME': '/home/cltbld', 17:39:01 INFO - 'LANG': 'en_US.UTF-8', 17:39:01 INFO - 'LANGUAGE': 'en_US:en', 17:39:01 INFO - 'LOGNAME': 'cltbld', 17:39:01 INFO - 'MAIL': '/var/mail/cltbld', 17:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:01 INFO - 'MOZ_NO_REMOTE': '1', 17:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:01 INFO - 'NO_EM_RESTART': '1', 17:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:01 INFO - 'PWD': '/builds/slave/test', 17:39:01 INFO - 'SHELL': '/bin/bash', 17:39:01 INFO - 'SHLVL': '1', 17:39:01 INFO - 'TERM': 'linux', 17:39:01 INFO - 'TMOUT': '86400', 17:39:01 INFO - 'USER': 'cltbld', 17:39:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:01 INFO - '_': '/tools/buildbot/bin/python'} 17:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:02 INFO - Downloading/unpacking blobuploader==1.2.4 17:39:02 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 17:39:02 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 17:39:02 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 17:39:02 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 17:39:02 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 17:39:02 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 17:39:04 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 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 17:39:04 INFO - Downloading docopt-0.6.1.tar.gz 17:39:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:04 INFO - Running setup.py install for blobuploader 17:39:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:04 INFO - Running setup.py install for requests 17:39:05 INFO - Running setup.py install for docopt 17:39:05 INFO - Successfully installed blobuploader requests docopt 17:39:05 INFO - Cleaning up... 17:39:05 INFO - Return code: 0 17:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:05 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:05 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 17:39:05 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 17:39:05 INFO - Using env: {'DISPLAY': ':0', 17:39:05 INFO - 'HOME': '/home/cltbld', 17:39:05 INFO - 'LANG': 'en_US.UTF-8', 17:39:05 INFO - 'LANGUAGE': 'en_US:en', 17:39:05 INFO - 'LOGNAME': 'cltbld', 17:39:05 INFO - 'MAIL': '/var/mail/cltbld', 17:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:05 INFO - 'MOZ_NO_REMOTE': '1', 17:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:05 INFO - 'NO_EM_RESTART': '1', 17:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:05 INFO - 'PWD': '/builds/slave/test', 17:39:05 INFO - 'SHELL': '/bin/bash', 17:39:05 INFO - 'SHLVL': '1', 17:39:05 INFO - 'TERM': 'linux', 17:39:05 INFO - 'TMOUT': '86400', 17:39:05 INFO - 'USER': 'cltbld', 17:39:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:05 INFO - '_': '/tools/buildbot/bin/python'} 17:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:05 INFO - Running setup.py (path:/tmp/pip-N__BE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:05 INFO - Running setup.py (path:/tmp/pip-xxHK7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:05 INFO - Running setup.py (path:/tmp/pip-bdZArL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:05 INFO - Running setup.py (path:/tmp/pip-3mTFbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:05 INFO - Running setup.py (path:/tmp/pip-1ywd3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:05 INFO - Running setup.py (path:/tmp/pip-TDGseY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:06 INFO - Running setup.py (path:/tmp/pip-Pw8g2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:06 INFO - Running setup.py (path:/tmp/pip-3Hn0Z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:06 INFO - Running setup.py (path:/tmp/pip-626yeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:06 INFO - Running setup.py (path:/tmp/pip-k4UPRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:06 INFO - Running setup.py (path:/tmp/pip-2aHYij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:06 INFO - Running setup.py (path:/tmp/pip-jbhF3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:06 INFO - Running setup.py (path:/tmp/pip-LLA6sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:06 INFO - Running setup.py (path:/tmp/pip-rHF1Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:06 INFO - Running setup.py (path:/tmp/pip-OfyaK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:06 INFO - Running setup.py (path:/tmp/pip-VCF0fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:06 INFO - Running setup.py (path:/tmp/pip-d8qxPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:06 INFO - Running setup.py install for manifestparser 17:39:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:06 INFO - Running setup.py install for mozcrash 17:39:07 INFO - Running setup.py install for mozdebug 17:39:07 INFO - Running setup.py install for mozdevice 17:39:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for mozfile 17:39:07 INFO - Running setup.py install for mozhttpd 17:39:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for mozinfo 17:39:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for mozInstall 17:39:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for mozleak 17:39:07 INFO - Running setup.py install for mozlog 17:39:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for moznetwork 17:39:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:07 INFO - Running setup.py install for mozprocess 17:39:08 INFO - Running setup.py install for mozprofile 17:39:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:08 INFO - Running setup.py install for mozrunner 17:39:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:08 INFO - Running setup.py install for mozscreenshot 17:39:08 INFO - Running setup.py install for moztest 17:39:08 INFO - Running setup.py install for mozversion 17:39:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:08 INFO - Cleaning up... 17:39:08 INFO - Return code: 0 17:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39: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')]} 17:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39: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')]} 17:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:08 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:08 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 17:39:08 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 17:39:08 INFO - Using env: {'DISPLAY': ':0', 17:39:08 INFO - 'HOME': '/home/cltbld', 17:39:08 INFO - 'LANG': 'en_US.UTF-8', 17:39:08 INFO - 'LANGUAGE': 'en_US:en', 17:39:08 INFO - 'LOGNAME': 'cltbld', 17:39:08 INFO - 'MAIL': '/var/mail/cltbld', 17:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:08 INFO - 'MOZ_NO_REMOTE': '1', 17:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:08 INFO - 'NO_EM_RESTART': '1', 17:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:08 INFO - 'PWD': '/builds/slave/test', 17:39:08 INFO - 'SHELL': '/bin/bash', 17:39:08 INFO - 'SHLVL': '1', 17:39:08 INFO - 'TERM': 'linux', 17:39:08 INFO - 'TMOUT': '86400', 17:39:08 INFO - 'USER': 'cltbld', 17:39:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:08 INFO - '_': '/tools/buildbot/bin/python'} 17:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:08 INFO - Running setup.py (path:/tmp/pip-EeKcPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:08 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)) 17:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:08 INFO - Running setup.py (path:/tmp/pip-DUw_qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:09 INFO - Running setup.py (path:/tmp/pip-fEpag2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:09 INFO - Running setup.py (path:/tmp/pip-rwt8u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:09 INFO - Running setup.py (path:/tmp/pip-IBzApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:09 INFO - Running setup.py (path:/tmp/pip-Gp7Ogy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:09 INFO - Running setup.py (path:/tmp/pip-qr9Kpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:09 INFO - Running setup.py (path:/tmp/pip-zVJCmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:09 INFO - Running setup.py (path:/tmp/pip-6lpNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:09 INFO - Running setup.py (path:/tmp/pip-zi9VqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:09 INFO - Running setup.py (path:/tmp/pip-FLmn2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:09 INFO - Running setup.py (path:/tmp/pip-2leCWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:09 INFO - Running setup.py (path:/tmp/pip-JZKJuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:09 INFO - Running setup.py (path:/tmp/pip-7Mm30Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:09 INFO - Running setup.py (path:/tmp/pip-wP8Qq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:09 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)) 17:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:09 INFO - Running setup.py (path:/tmp/pip-glGVlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:10 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)) 17:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:10 INFO - Running setup.py (path:/tmp/pip-r0HBBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:10 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)) 17:39:10 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)) 17:39:10 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)) 17:39:10 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)) 17:39:10 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)) 17:39:10 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)) 17:39:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:11 INFO - Downloading blessings-1.6.tar.gz 17:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:12 INFO - Installing collected packages: blessings 17:39:12 INFO - Running setup.py install for blessings 17:39:12 INFO - Successfully installed blessings 17:39:12 INFO - Cleaning up... 17:39:12 INFO - Return code: 0 17:39:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:12 INFO - Reading from file tmpfile_stdout 17:39:12 INFO - Current package versions: 17:39:12 INFO - argparse == 1.2.1 17:39:12 INFO - blessings == 1.6 17:39:12 INFO - blobuploader == 1.2.4 17:39:12 INFO - docopt == 0.6.1 17:39:12 INFO - manifestparser == 1.1 17:39:12 INFO - mozInstall == 1.12 17:39:12 INFO - mozcrash == 0.17 17:39:12 INFO - mozdebug == 0.1 17:39:12 INFO - mozdevice == 0.48 17:39:12 INFO - mozfile == 1.2 17:39:12 INFO - mozhttpd == 0.7 17:39:12 INFO - mozinfo == 0.9 17:39:12 INFO - mozleak == 0.1 17:39:12 INFO - mozlog == 3.1 17:39:12 INFO - moznetwork == 0.27 17:39:12 INFO - mozprocess == 0.22 17:39:12 INFO - mozprofile == 0.28 17:39:12 INFO - mozrunner == 6.11 17:39:12 INFO - mozscreenshot == 0.1 17:39:12 INFO - mozsystemmonitor == 0.0 17:39:12 INFO - moztest == 0.7 17:39:12 INFO - mozversion == 1.4 17:39:12 INFO - psutil == 3.1.1 17:39:12 INFO - requests == 1.2.3 17:39:12 INFO - wsgiref == 0.1.2 17:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:12 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 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:12 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 17:39:12 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 17:39:12 INFO - Using env: {'DISPLAY': ':0', 17:39:12 INFO - 'HOME': '/home/cltbld', 17:39:12 INFO - 'LANG': 'en_US.UTF-8', 17:39:12 INFO - 'LANGUAGE': 'en_US:en', 17:39:12 INFO - 'LOGNAME': 'cltbld', 17:39:12 INFO - 'MAIL': '/var/mail/cltbld', 17:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:12 INFO - 'MOZ_NO_REMOTE': '1', 17:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:12 INFO - 'NO_EM_RESTART': '1', 17:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:12 INFO - 'PWD': '/builds/slave/test', 17:39:12 INFO - 'SHELL': '/bin/bash', 17:39:12 INFO - 'SHLVL': '1', 17:39:12 INFO - 'TERM': 'linux', 17:39:12 INFO - 'TMOUT': '86400', 17:39:12 INFO - 'USER': 'cltbld', 17:39:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:12 INFO - '_': '/tools/buildbot/bin/python'} 17:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 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)) 17:39:12 INFO - Cleaning up... 17:39:12 INFO - Return code: 0 17:39:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:39:12 INFO - Using env: {'DISPLAY': ':0', 17:39:12 INFO - 'HOME': '/home/cltbld', 17:39:12 INFO - 'LANG': 'en_US.UTF-8', 17:39:12 INFO - 'LANGUAGE': 'en_US:en', 17:39:12 INFO - 'LOGNAME': 'cltbld', 17:39:12 INFO - 'MAIL': '/var/mail/cltbld', 17:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:12 INFO - 'MOZ_NO_REMOTE': '1', 17:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:12 INFO - 'NO_EM_RESTART': '1', 17:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:12 INFO - 'PWD': '/builds/slave/test', 17:39:12 INFO - 'SHELL': '/bin/bash', 17:39:12 INFO - 'SHLVL': '1', 17:39:12 INFO - 'TERM': 'linux', 17:39:12 INFO - 'TMOUT': '86400', 17:39:12 INFO - 'USER': 'cltbld', 17:39:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:12 INFO - '_': '/tools/buildbot/bin/python'} 17:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:12 INFO - Downloading/unpacking jsonschema 17:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:14 INFO - Downloading/unpacking functools32 (from jsonschema) 17:39:14 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 17:39:14 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 17:39:14 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 17:39:14 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 17:39:14 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 17:39:14 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 17:39:14 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:15 INFO - warning: no files found matching '*.txt' 17:39:15 INFO - no previously-included directories found matching 'build' 17:39:15 INFO - no previously-included directories found matching 'dist' 17:39:15 INFO - no previously-included directories found matching '.git*' 17:39:15 INFO - Installing collected packages: jsonschema, functools32 17:39:15 INFO - Running setup.py install for functools32 17:39:15 INFO - warning: no files found matching '*.txt' 17:39:15 INFO - no previously-included directories found matching 'build' 17:39:15 INFO - no previously-included directories found matching 'dist' 17:39:15 INFO - no previously-included directories found matching '.git*' 17:39:15 INFO - Successfully installed jsonschema functools32 17:39:15 INFO - Cleaning up... 17:39:15 INFO - Return code: 0 17:39:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc3c1e83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, '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': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', '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 17:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:39:15 INFO - Using env: {'DISPLAY': ':0', 17:39:15 INFO - 'HOME': '/home/cltbld', 17:39:15 INFO - 'LANG': 'en_US.UTF-8', 17:39:15 INFO - 'LANGUAGE': 'en_US:en', 17:39:15 INFO - 'LOGNAME': 'cltbld', 17:39:15 INFO - 'MAIL': '/var/mail/cltbld', 17:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:15 INFO - 'MOZ_NO_REMOTE': '1', 17:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:15 INFO - 'NO_EM_RESTART': '1', 17:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:15 INFO - 'PWD': '/builds/slave/test', 17:39:15 INFO - 'SHELL': '/bin/bash', 17:39:15 INFO - 'SHLVL': '1', 17:39:15 INFO - 'TERM': 'linux', 17:39:15 INFO - 'TMOUT': '86400', 17:39:15 INFO - 'USER': 'cltbld', 17:39:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:15 INFO - '_': '/tools/buildbot/bin/python'} 17:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:15 INFO - Downloading/unpacking flake8 17:39: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 17:39: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 17:39: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 17:39: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 17:39: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 17:39: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 17:39:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:39:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:39:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:18 INFO - no previously-included directories found matching 'docs/_build' 17:39:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:39:18 INFO - Running setup.py install for pep8 17:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:39:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:39:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:39:18 INFO - no previously-included directories found matching 'docs/_build' 17:39:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:39:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:39:18 INFO - Cleaning up... 17:39:18 INFO - Return code: 0 17:39:18 INFO - Running post-action listener: _resource_record_post_action 17:39:18 INFO - Running post-action listener: _start_resource_monitoring 17:39:18 INFO - Starting resource monitoring. 17:39:18 INFO - ##### 17:39:18 INFO - ##### Finished create-virtualenv step (success) 17:39:18 INFO - ##### 17:39:18 INFO - ##### 17:39:18 INFO - ##### Running install step. 17:39:18 INFO - ##### 17:39:18 INFO - Running pre-action listener: _resource_record_pre_action 17:39:18 INFO - Running main action method: install 17:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:18 INFO - Reading from file tmpfile_stdout 17:39:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:18 INFO - Reading from file tmpfile_stdout 17:39:18 INFO - Output received: 17:39:18 INFO - Usage: mozinstall [options] installer 17:39:18 INFO - Options: 17:39:18 INFO - -h, --help show this help message and exit 17:39:18 INFO - -d DEST, --destination=DEST 17:39:18 INFO - Directory to install application into. [default: 17:39:18 INFO - "/builds/slave/test"] 17:39:18 INFO - --app=APP Application being installed. [default: firefox] 17:39:18 INFO - mkdir: /builds/slave/test/build/application 17:39:18 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'] 17:39:18 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 17:39:34 INFO - Reading from file tmpfile_stdout 17:39:34 INFO - Output received: 17:39:34 INFO - /builds/slave/test/build/application/firefox/firefox 17:39:34 INFO - Running post-action listener: _resource_record_post_action 17:39:34 INFO - ##### 17:39:34 INFO - ##### Finished install step (success) 17:39:34 INFO - ##### 17:39:34 INFO - ##### 17:39:34 INFO - ##### Running run-tests step. 17:39:34 INFO - ##### 17:39:34 INFO - Running pre-action listener: _resource_record_pre_action 17:39:34 INFO - Running main action method: run_tests 17:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:34 INFO - Python 2.7.3 17:39:34 INFO - Return code: 0 17:39:34 INFO - grabbing minidump binary from tooltool 17:39:34 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')]} 17:39:34 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 0x17309c0>, '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 0x17318c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1731d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:34 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 17:39:34 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 17:39:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:34 INFO - Return code: 0 17:39:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:39:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:39:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:39:35 INFO - Return code: 0 17:39:35 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/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 17:39:35 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/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 17:39:35 INFO - Using env: {'DISPLAY': ':0', 17:39:35 INFO - 'HOME': '/home/cltbld', 17:39:35 INFO - 'LANG': 'en_US.UTF-8', 17:39:35 INFO - 'LANGUAGE': 'en_US:en', 17:39:35 INFO - 'LOGNAME': 'cltbld', 17:39:35 INFO - 'MAIL': '/var/mail/cltbld', 17:39:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:35 INFO - 'MOZ_NO_REMOTE': '1', 17:39:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:35 INFO - 'NO_EM_RESTART': '1', 17:39:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:35 INFO - 'PWD': '/builds/slave/test', 17:39:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:35 INFO - 'SHELL': '/bin/bash', 17:39:35 INFO - 'SHLVL': '1', 17:39:35 INFO - 'TERM': 'linux', 17:39:35 INFO - 'TMOUT': '86400', 17:39:35 INFO - 'USER': 'cltbld', 17:39:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975', 17:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:35 INFO - '_': '/tools/buildbot/bin/python'} 17:39:35 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/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 17:39:35 INFO - mozversion application_buildid: 20160506163539 17:39:35 INFO - mozversion application_changeset: 738ec20418cc728910419aa60f98ae62b429facf 17:39:35 INFO - mozversion application_display_name: Nightly 17:39:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:35 INFO - mozversion application_name: Firefox 17:39:35 INFO - mozversion application_remotingname: firefox 17:39:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:39:35 INFO - mozversion application_vendor: Mozilla 17:39:35 INFO - mozversion application_version: 49.0a1 17:39:35 INFO - mozversion platform_buildid: 20160506163539 17:39:35 INFO - mozversion platform_changeset: 738ec20418cc728910419aa60f98ae62b429facf 17:39:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:39:35 INFO - mozversion platform_version: 49.0a1 17:39:35 INFO - using testdate: 1462581575 17:39:35 INFO - actual date: 1462581575 17:39:35 INFO - starting webserver on 'localhost:58312' 17:39:35 INFO - SUITE-START | Running 2 tests 17:39:35 INFO - TEST-START | dromaeo_css 17:39:35 INFO - operating with platform_type : linux_ 17:39:35 INFO - Initialising browser for dromaeo_css test... 17:39:35 INFO - TEST-INFO | started process 22952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54G5hh/profile http://localhost:58312/getInfo.html) 17:39:39 INFO - PROCESS | 22952 | 17:39:39 INFO - PROCESS | 22952 | (process:23018): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:39:40 INFO - PROCESS | 22952 | __metrics Screen width/height:1600/1200 17:39:40 INFO - PROCESS | 22952 | colorDepth:24 17:39:40 INFO - PROCESS | 22952 | Browser inner width/height: 1024/697 17:39:40 INFO - PROCESS | 22952 | __metrics 17:39:41 ERROR - PROCESS | 22952 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:39:42 INFO - TEST-INFO | 22952: exit 0 17:39:42 INFO - Browser initialized. 17:39:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:42 INFO - TEST-INFO | started process 23069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp54G5hh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:44 INFO - PROCESS | 23069 | 17:39:44 INFO - PROCESS | 23069 | (process:23130): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:39:54 INFO - PROCESS | 23069 | RSS: Main: 164454400 17:39:54 INFO - PROCESS | 23069 | 17:40:43 INFO - PROCESS | 23069 | 1462581643934 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] 17:42:55 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58312/tests/dromaeo/cssquery-ext.html) 17:42:56 INFO - PROCESS | 23069 | RSS: Main: 167141376 17:42:56 INFO - PROCESS | 23069 | 17:45:58 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-ext.html (next: http://localhost:58312/tests/dromaeo/cssquery-jquery.html) 17:45:59 INFO - PROCESS | 23069 | RSS: Main: 166297600 17:45:59 INFO - PROCESS | 23069 | 17:49:01 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58312/tests/dromaeo/cssquery-mootools.html) 17:49:01 INFO - PROCESS | 23069 | RSS: Main: 168349696 17:49:01 INFO - PROCESS | 23069 | 17:52:03 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58312/tests/dromaeo/cssquery-prototype.html) 17:52:04 INFO - PROCESS | 23069 | RSS: Main: 165830656 17:52:04 INFO - PROCESS | 23069 | 17:55:07 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58312/tests/dromaeo/cssquery-yui.html) 17:55:07 INFO - PROCESS | 23069 | RSS: Main: 165941248 17:55:07 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | Cycle 1(1): loaded http://localhost:58312/tests/dromaeo/cssquery-yui.html (next: http://localhost:58312/tests/dromaeo/cssquery-dojo.html) 17:58:10 INFO - PROCESS | 23069 | RSS: Main: 168009728 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | __start_tp_report 17:58:10 INFO - PROCESS | 23069 | _x_x_mozilla_page_load 17:58:10 INFO - PROCESS | 23069 | _x_x_mozilla_page_load_details 17:58:10 INFO - PROCESS | 23069 | |i|pagename|runs| 17:58:10 INFO - PROCESS | 23069 | |0;dojo.html;2590.753878381554;2638.1953504181224;2642.062067965873;2658.5214661360947;2666.626672265882;4529.7282163070195;4601.240795268781;4632.212523870941;4725.8582242532775;4761.54765297297;4574.153781550415;4611.700239484431;4634.536546345364;4642.489326174118;4660.6504512161555;4265.040365917667;4289.142171565683;4369.4756629204385;4375.628071613916;4397.450318710161;4312.288472402066;4315.546867578906;4368.148211098837;4381.07997320563;4384.671149663772;4202.3696445533415;4276.166147601219;4285.314349704033;4310.267254566731;4362.716423432466;4298.140371925628;4309.547497512747;4317.892052698676;4320.330348795942;4364.585364390377;4331.913361732779;4337.175936572073;4346.174226896879;4358.259095953664;4388.780560971971;4608.8386906458445;4612.53874612536;4677.0178262564905;4678.6257099432305;4685.273782563674;5062.341895553554;5088.313077734532;5101.13280742271;5107.846764597031;5140.974295128501;5000.0999820032375;5086.338775959139;5119.744012799382;5120.15517439622;5130.230465430178;4692.976535117336;4711.575958163782;4714.66997310185;4728.361671174416;4761.928571071437;5164.664296820694;5167.793288268427;5176.7411629418375;5178.741062946838;5186.792528298825;4832.975835120802;4833.299171620095;4853.02939412119;4951.801927922915;4995.925061124086;4962.454130045692;4966.1309270877455;4970.030843985388;4984.651074424828;5005.299258103868;4874.2201247800185;4945.134601444733;5012.147934851084;5014.749262536931;5074.898502029939;4832.347633069561;4971.130052240844;4978.054169707744;4997.275395067695;5011.674241174312;4311.568843115726;4321.870343889688;4329.848455304049;4339.956600433955;4369.563043695605;3755.586885442599;3756.962430375716;3769.6607305342104;3780.092777733379;3796.468494410785;4269.847141271839;4298.849540266138;4318.050028993616;4366.6506679465565;4369.890752731207;5013.749312534359;5017.774200161001;5053.0399224147295;5064.11378008847;5088.389393272831;4321.40110639772;4352.1513304905875;4352.2818734909015;4380.8685739427865;4412.867613971586;4427.070315233773;4505.7296562206375;4520.254158063883;4561.270196768501;4575.336576196433;4768.642351823558;4781.474037855833;4801.351817504592;4806.687565308243;4807.399075115611;5059.139946209227;5084.567811736044;5087.592992560512;5091.974540127276;5097.133487307093;4584.358189853357;4718.528147185254;4740.288956656529;4756.262779269219;4808.711477311373;4974.0797952378925;4994.350734404504;5016.147254966591;5022.045811295842;5048.545630893237;5065.088284108896;5069.214271787879;5071.239314102767;5071.568916641979;5129.666571672829;4691.390119284471;4735.384400027974;4805.231163014041;4843.539863712942;4873.7806798694855;4800.495947925418;4806.110869489155;4823.3729615149805;4828.106800241966;4854.611631069577;4786;4799.7120172788345;4807.399075115611;4815.085133824562;4822.107910036654;4810.278458231293;4887.218045112765;4927.063857867137;4933.58064564516;4958.330625365529;4794.113089078532;4840.540148685869;4855.053264613366;4855.320255164351;4901.068796928572 17:58:10 INFO - PROCESS | 23069 | |1;ext.html;586.4838941731279;605.5186127029009;616.7286393986645;636.9968150159249;641.1312671330351;35432.114197145085;39365.40951885724;39486.60513394865;39645.60354396455;39666.80166599163;40120.39819402711;40422.19155616886;40856.79571602145;40895.38656920149;40907.59092409075;7828.569428681434;7948.880766788503;7952.920470795305;7959.681612735483;7969.083555391117;7799.142094369615;7839.059312882462;7858.803529911741;7879.684812607489;7913.683452661915;7873.881891771599;7882.645280962371;7914.604269786517;7941.64262608184;7961.243681850215;7849.960750196241;7873;7882.369410447208;7886.605669716549;7903.1701671324545;7805.1804560520895;7832.56920869352;7853.371730261565;7857.567833769141;7883.960580197062;31344.21639459009;38798.224035519415;39055.60944390548;39156.412653810214;39167.60832391697;3164.841757912095;3166.224275052604;3288.4574045282498;3328.3509715605223;3440.0539851540775;28545.287282762893;28751.71248287511;29815.70184298151;30604.387912241855;31453.68546314553;3513.9121521962156;3524.4889491023914;3591.90556492412;3607.981960090209;3626.782393056425;251487;258140;258643;258822;259295;61499.6925015381;62006.68996655078;62252.688736556935;62341.688291558254;62646.68676656679;38004.61995380066;38984.805075975004;39085.41371879424;65577.67211164009;66114.33885661082;15876.206189690469;15923.283452244677;15934.203289835461;16039.518814435585;16194.75707864383;12126.211796233216;12159.75680486403;12309.199902006341;12331.938340308421;12359.69100772488;21127.788722112582;21239.575208495742;21287.148514059263;21291;21340.146394144373;7865.410094242955;7978.481398709066;8025.759227223192;8278.875816862752;8334.291585215324;917.5733284022962;976.6191185437685;989.4261328429494;990.8117457683018;1043.2071625564627;28084.43831123366;28993.91502933032;29024.274393140342;29387.412251754846;29517.26206844803;1035.3994683083793;1045.6340280901622;1049.4280617063719;1092.251807511857;1113.9721506962392;15269.694606108038;15457.84542154564;15776.68446631061;15848.44530441429;16097.758533622005;358255;364686;365246;365423;366130;51678.22482662763;52980.47019529755;53074;53160.20259696108;53177;1272.4910035985495;1280.475005247844;1304.3282709404664;1311.3902035553322;1331.5872079655144;27968.44063118767;28479.43041139124;28648.57027144553;28747.71252287534;29454.705452945196;45184.32223516716;45408;45598.54401455943;45679.543204567526;46063.539364605924;305546;305667;306244;307248;307536;26345.20964371072;26602.733972660026;26675;26795.732042679323;26854.865725671247;44916.55083449124;45131.77434112808;45901;45902.31146532871;45927;37186.44220336643;37927.43108853425;37992.810035949646;38217.617823821405;38838.6116138835;36855.81572092122;37471.250574988895;37786.62213377831;38246.617533824305;38523;32620.510692340107;33076.503852442715;38200.61799381971;38713;39323;33098.83450582732;34216.82891585526;34653.306933861684;34836.477452837724;35095.824520877235;25827.741722582534;26236;26633.733662663126;26819.195424137306;27005.719278735527 17:58:10 INFO - PROCESS | 23069 | |2;jquery.html;377.7752237418735;378.88444024572505;379.2131327495447;393.75193628014347;394.6901682179488;16604.920680155796;17425.390111346107;17858.73211901821;18211.817881821178;18241.270349186034;15628.84371156288;15738.527844164664;15867.920660396681;16008.83991160088;16144.75782863255;5105.821296254632;5269.394019687727;5296.09966305727;5297.920531192035;5301.098813201765;3609.620989796073;5689.51639110674;5989.610675306091;5997.88004239915;6122.295935967376;5508.889822203553;5989.460948514633;6039.879202415949;6075.058365953262;6077.544184186182;5751.511121554673;5861.150133230701;5888.205092312547;5893.14549390336;5915.319738230094;4567.269236922077;4870.488598697157;4906.460289368167;4935.210366341368;4961.107000739866;12478.251304921734;12497.75004499914;12818.230906145567;12910.612681619567;12917.289549074798;1924.1437560285679;1957.354073155855;1982.8611997160206;2122.8089471947446;2169.739631244245;9160.312976526788;9530.809383812355;9547.761305967406;9629.133377996013;9738.269629777724;1705.2752580153385;1745.3280487012464;1803.7564928734716;1942.6692715489935;1958.8139126782933;68963.65518172427;69993.30006699919;71709;72257;72409.6379518099;9378.67174648884;9661.71014869555;9702.9029709702;9712.757181070388;9874.605015799287;12954.870451295366;13092.738145237232;13136.474541018444;13565.660858478617;13591.52429664957;7043.788686339418;7052.894206586905;7108.324709152622;7201.747938822116;7230.349268565854;7178.318059784312;7253.673584688596;7301.342879140797;7389;7440.73957411488;4039.939400908989;4054.533728621246;4061.593840615974;4266.573342665771;4549.135664223787;1681.6636672665516;2913.344497488091;3057.7400920921973;3335.566376371105;3496.283261931298;830.7538691962056;946.1012038563255;951.8191543606692;976.8192884316425;986.7237173591406;16529.752053719203;17082.23129959155;17283.395081172097;17442.91278543599;17601.383951561635;910.3763921713647;914.9085091490798;926.9212116970133;935.6023689931752;989;9573.808523829624;9657.179139773058;9750;9786.706398808046;9910.950445247727;259971;427411;436303;439141;443189;49809;61699.691501542206;88595;88727.11272887318;89833.55083224672;1004.914582260516;1009.7828966772179;1023.6059117239768;1027.3630349183554;1029.2126523209602;15183.696326073637;15340.846591534388;15351.23243837826;15360.923195383952;15586.766198506804;35432.46851297181;35833;35839.28321433609;36311.81844090763;36466.45300320444;50557.241641374676;52884;52912.735436322575;53018;53097.20354194613;7725.49784264021;7818.882716759367;8036.1160272368825;8048.356131509348;8115.715949941724;11407.543698251977;12026.579069732517;12218.938905305416;12587.685307867376;12901.870981290067;9580.856287155837;9894.851577226204;9958.452285124098;9980.950095249478;10060.245481588763;4845.63657725665;8913.573828187458;9979.251556133464;10109.797804044025;10596.15230781551;9647.276454266099;10789.892101078889;10863.456827158452;10863.728406789893;11114.333140011626;7972.681092756457;8067.152948940511;8192.631331590212;8265.380096492907;8271.54506502148;8026.43814932949;10255.384676919408;10279.53742081623;10377.584896604052;10532 17:58:10 INFO - PROCESS | 23069 | |3;mootools.html;1512.56135720641;1518.2181176694003;1716.7253239481686;1844.4282272495536;1855.9721604175932;6623.9006414903815;7288.234735352791;7358.595277259756;7898.526088434691;7931.643076061577;7505.699772009113;7738.535687858733;7749.7675069748;7769.456138070337;7775.572343521104;2250.03248603101;2280.338701776483;2281.452451411666;2286.6798648189265;2290.4502919299416;2181.770914054025;2218.389942765736;2256.8645881247094;2259.3334966185016;2262.751097379287;2180.90185941633;2197.8681279123225;2209.933701988943;2221.0449506712107;2262.9434264143447;2148.957020859574;2155.7305336832897;2167.5881582499355;2176.3253391448543;2179.3461961411595;2138.9786102138937;2158.3740715192575;2158.4495953531905;2162.7296587926508;2163.134746101556;7613.581253031081;7619.885701714478;7651.846963060708;7655.387568994467;7656.885146722803;4481;4498.572635599613;4677.415323084614;4697.389339385858;4711.363965864599;2881.9135425937257;2992.431438026768;3018.109657650998;3020.0939718084487;3023.5313526403443;923.8891333040011;941.2187884056217;968.2205824311427;972.6790159247431;983.3608154699431;10267.229957753123;10391.688249352532;10407.947960260226;10429.478526073743;10448.843267350996;4033.193361327746;4137.317342638431;4155.625993660585;4162.501499460192;4203.516595591485;8282.58587070644;8303.294219991369;8306.377021723394;8334.291585215204;8370.204830541088;4485.48416932057;4565.977170114128;4597.0346227291975;4598.172328980749;4660.790264438108;3725.1059745660846;4176.937345939813;4255.085156691264;4344.9131017380105;4361;3349.39710852049;3372.2412457197424;3432.1591210153674;3468.0462872710204;3477.756557040983;1013.1135256650431;1018.3177271228295;1029.444100185906;1033.8811036730722;1042.6246551241547;788.9566073865992;914.264017465933;937.1237892570468;950.6245033211843;952.9380590261611;5291.761870715827;5371.3822910365025;5434.972825135849;5590.91613625796;5607.355154157242;860.2064695110639;911.9635214591342;954.88063992001;960.7309953212972;961.0869673809908;3609;3677.687396571268;3780.8865734028022;3788.242351529705;3788.299164654548;8860.512671802984;9151.222146117654;9186.908130918606;9204.355695101412;9221.262299016063;9120.81758364829;9131.771705707277;9204.033576474507;9217.677381291622;9235.353525253302;7204.423646108299;7355.59544225062;7359.926400735924;7369.299916507923;7378.262173782578;5230.764615592231;5345.545628621455;5349.358077030781;5474.616776825584;5523.834284971457;7962.442629015914;8562.143785621389;8576.485410875368;8594.140585941606;8695.391322607356;8241.629126689193;8504.149585041447;8536;8617;8683.478991260545;5749.856253593526;6504.089427480251;6723.798286051427;6725.260221375743;6893.517453778188;7434.182239953492;7454.180040195466;7460.328570428687;7481.887771683538;7518.173000969999;6647.700853461509;6876.17485901695;6888.345607167311;6941.618210998444;6977.546459480118;6678.83302917431;6735.360140786617;6747.797566073025;6768.08630834831;6794.66026698673;5945.435183657545;6159.322474527888;6247.531435142473;6267.310595834363;6271.6550589718;4506.481754598132;4565.223911934912;4607.5622815833785;4608.5621865922685;4697.107549565571;4395.582419670126;4474.239379305461;4483.7982290797645;4489;4566.292224705176 17:58:10 INFO - PROCESS | 23069 | |4;prototype.html;300.2074523258598;310.492345015899;314.7906642083015;318.28862492329637;319.2147317598707;4674.85975420737;4771.522847715227;4794.68834525756;4901.58336541394;4915.434725006621;4826.420829500456;4827.78274977626;4827.78274977626;4830.661853670244;4833.589144922686;3834.9041273968096;3839.1937693084487;3839.539255289369;3842.538895332557;3844.2119365529998;3680.7791532508;3841.519810023747;3842.6733727633186;3850.210706805098;3861.942070868939;3745.8876233712895;3766.171442282707;3816.0841398064404;3822.6750726188307;3831.3486707259694;3761.946654936622;3775.546934367866;3793.1275806564645;3793.829277682497;3803.9919421353366;3161.7944833585975;3271.6237632672073;3299.7195238404765;3372.9156771080675;3395.8811441599423;4617.007343421181;4619.907601847978;4627.444706635191;4633.374494443241;4646.279826626878;4212.873613791591;4226.3026600610865;4230.8519201827785;4234.3860140279485;4256.5105012923605;4890.584300334476;4968.205087186033;4995;4997.750112494397;5004.074246264453;3555.715542756573;3566.821658917044;3569.785812851237;3581.982090089559;3586.211033572636;5208.635395522315;5228.92156617651;5242.55438287746;5247.16045432729;5271.894562108736;3651.653092956165;3664.6518580734787;3670.284294562535;3684.5394325709285;3694.538182727159;3584.336897673939;3695.9445608315896;3698.7041036716996;3700.965208529034;3715.758475699071;4231.767252801125;4260.339647354665;4273.594008569181;4274.764887931194;4276.48682158143;5031.622628302819;5042.117629414838;5051.913838524735;5054.368203974504;5058.570021548209;1179.55177032727;1212.6483319837325;1225.5281716539196;1237.888590026902;1250.5060501102014;838.2581415447252;851.4805968359295;861.1560670542904;864.8356812205661;867.9566021698889;4289.635380992589;4295.5060168080445;4300.956990430118;4303.720258183208;4308.655307575386;5006.874828129253;5009.524095210949;5012.373453318335;5025.221090730943;5036.345275114285;4263.720883734867;4278.7860606969525;4279.97860010698;4285.914281714348;4296.334068219431;2498.9875050624632;2631.1580294306023;2631.4210873607776;2644.801639877017;2664.653595032672;4651.162790697639;4712.858614241578;4719.386479757678;4758.429718192988;4766.1659209638865;5033.968036552498;5072.188449848007;5080.949190508121;5098.5411312982005;5108.795648174031;4548.385967894292;4897.706137631753;4927.975360123177;4942.604591632733;4949.232868905326;5237.407483295793;5245.790168393374;5254;5266.34170728659;5267.841964741064;4824.300476430968;5093.784203871328;5137.691738495702;5146.76839542214;5153.45888681698;4899.657024008286;4909.361782968192;4929.630277729113;4939.259111133215;4970.701757894538;3821.541415030214;3845.0777409168672;3861.6524512793985;3869.0714228584375;3870.187260675177;4730.905381892412;5237.659552129099;5243.764030618708;5246.632735708464;5254;5086.923696144487;5088.516590923857;5092.185250359925;5098.980203959297;5106.514881086291;5077.136886729191;5080.771365288497;5089.898202035864;5093.108705976365;5109.9233511498105;4892.951070489249;4999.800007999639;5018.924716129334;5021.171506701354;5037.823676171316;5075.3402057732255;5105.974470127626;5116.386033675983;5137.357830271216;5148.841510660071;4977.104121258209;4984.2025275955675;4985.5762260208285;4988.201887697951;4994.1509943309 17:58:10 INFO - PROCESS | 23069 | |5;yui.html;705.4673721340387;713.7252157919199;756.8486302739452;781.6209138567793;787.4684587903164;12527.624171274876;12672.68318292042;13032.087753857233;13198.868011319884;13465.259410732406;12799.808002879941;12889.355532223399;12911.548095816648;12936.28850413227;12962.48150073996;676.4588329336535;863.4085651328828;863.4517081653148;875.155474966657;888.6045709659204;866.9826603467927;874.4054043250619;874.5845723281423;875.0986483921571;875.2429148786285;915.5330781301551;915.9771005724876;918.5315489100574;920.9815803683922;922.1976880114277;902.4224496322327;903.4759839293195;907.7549061753323;909.7316291693966;913.4108500017452;672.7275453441364;675.3955210086945;677.7153595489906;677.9254282029023;680.6664734280216;12274.877251227552;12331.938340308241;12365.567205147776;12366.62900112998;12446.502139914393;12492.937535312356;12546.435410406553;12563.18339307942;12661.113722039461;13146.86853131466;9986.465632194826;10082.949585252027;10278.640247591298;10319.329243599143;10447.634332798316;3329.1011426914597;3411.710004649608;3418.282160746246;3515.9472607910902;3522.119470132467;43815.12369752587;43891.12217755627;43910.56089439129;43925;44085.33871991923;9739.41563506192;9868.703938881845;9992.350497217658;10007.299489035844;10294.330868493675;17252.396166134124;17470.126493675267;18265.726014109798;18403.355882544045;18441.631167376847;6769.120014398195;6849.623270720059;6859.176898772179;6880.415164710956;6970.302969703091;3805.486259355007;3807.333716599584;3820.2168555446624;3865.5168103987003;3872.5933776953016;2845.5304874695444;2920.007197552842;2921.415716856637;2926.1514160893103;2929.3701854101046;524.5732893219637;525.8632755483602;529.9841004769863;532.1857557936363;539.8704310965419;469.50925341065295;528.3184691747603;617.102116420607;631.4884943196026;633.3349982518338;7209.819754506179;7220.530665506725;7322.231165727629;7325.670344834495;7360.190379058299;515.2220147577185;597.489146779506;603.9939600604025;614.265952187141;620.6152185644929;3530.7528473007155;3583.7312201584987;3592.7844329340323;3673.7876500754687;3691.90770230741;49485.257721134214;50833.74583127061;51515.48484515182;51765.2235216472;51961;45113;45302.32046519305;45732.77133614311;46266.5373346269;46588.7670561645;42322.78838605787;42759.786201069415;42760;43245.35131973023;43353.34969975453;7051.012858199959;7158.141023077264;7159.284071592799;7175.390091842252;7312.378447831994;28092.157235282975;29097.272568185967;29238;29282.853585731937;29571.556426654046;34856.65143348635;37203.06992325214;37522.624773751915;37823.243535129695;37923.24153516969;9227.630894764134;9292.72121836319;9565.473898935625;9631.614735410505;9677.951610241904;9499.952500237454;9766.951165244129;9822.5088745561;9823;10060.899391005996;9554.42673439568;9690.75773105678;9691.70924872255;9782.217422606032;9891.159251463418;9584.66453674146;9615.9038409615;9738.464384458923;9758.414495130031;10099.848502272618;9606.759831004281;9677.080677335642;9814.65648702292;9846.950765246127;10032.899671003197;8189.50862948225;8274.29668478162;8322.50064996102;8437.451565648213;8607.612657430305;8417;8452.915470845213;8587.65649374018;8714.738557843275;8732.301415886841 17:58:10 INFO - PROCESS | 23069 | __end_tp_report 17:58:10 INFO - PROCESS | 23069 | __start_cc_report 17:58:10 INFO - PROCESS | 23069 | _x_x_mozilla_cycle_collect,361 17:58:10 INFO - PROCESS | 23069 | __end_cc_report 17:58:10 INFO - PROCESS | 23069 | __startTimestamp1462582690508__endTimestamp 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | ------- Summary: start ------- 17:58:10 INFO - PROCESS | 23069 | Number of tests: 6 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#0] dojo.html Cycles:165 Average:4646.80 Median:4781.47 stddev:481.57 (10.1%) stddev-sans-first:455.24 17:58:10 INFO - PROCESS | 23069 | Values: 2590.8 2638.2 2642.1 2658.5 2666.6 4529.7 4601.2 4632.2 4725.9 4761.5 4574.2 4611.7 4634.5 4642.5 4660.7 4265.0 4289.1 4369.5 4375.6 4397.5 4312.3 4315.5 4368.1 4381.1 4384.7 4202.4 4276.2 4285.3 4310.3 4362.7 4298.1 4309.5 4317.9 4320.3 4364.6 4331.9 4337.2 4346.2 4358.3 4388.8 4608.8 4612.5 4677.0 4678.6 4685.3 5062.3 5088.3 5101.1 5107.8 5141.0 5000.1 5086.3 5119.7 5120.2 5130.2 4693.0 4711.6 4714.7 4728.4 4761.9 5164.7 5167.8 5176.7 5178.7 5186.8 4833.0 4833.3 4853.0 4951.8 4995.9 4962.5 4966.1 4970.0 4984.7 5005.3 4874.2 4945.1 5012.1 5014.7 5074.9 4832.3 4971.1 4978.1 4997.3 5011.7 4311.6 4321.9 4329.8 4340.0 4369.6 3755.6 3757.0 3769.7 3780.1 3796.5 4269.8 4298.8 4318.1 4366.7 4369.9 5013.7 5017.8 5053.0 5064.1 5088.4 4321.4 4352.2 4352.3 4380.9 4412.9 4427.1 4505.7 4520.3 4561.3 4575.3 4768.6 4781.5 4801.4 4806.7 4807.4 5059.1 5084.6 5087.6 5092.0 5097.1 4584.4 4718.5 4740.3 4756.3 4808.7 4974.1 4994.4 5016.1 5022.0 5048.5 5065.1 5069.2 5071.2 5071.6 5129.7 4691.4 4735.4 4805.2 4843.5 4873.8 4800.5 4806.1 4823.4 4828.1 4854.6 4786.0 4799.7 4807.4 4815.1 4822.1 4810.3 4887.2 4927.1 4933.6 4958.3 4794.1 4840.5 4855.1 4855.3 4901.1 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#1] ext.html Cycles:180 Average:47527.00 Median:37021.13 stddev:81900.26 (221.2%) stddev-sans-first:82054.18 17:58:10 INFO - PROCESS | 23069 | Values: 586.5 605.5 616.7 637.0 641.1 35432.1 39365.4 39486.6 39645.6 39666.8 40120.4 40422.2 40856.8 40895.4 40907.6 7828.6 7948.9 7952.9 7959.7 7969.1 7799.1 7839.1 7858.8 7879.7 7913.7 7873.9 7882.6 7914.6 7941.6 7961.2 7850.0 7873.0 7882.4 7886.6 7903.2 7805.2 7832.6 7853.4 7857.6 7884.0 31344.2 38798.2 39055.6 39156.4 39167.6 3164.8 3166.2 3288.5 3328.4 3440.1 28545.3 28751.7 29815.7 30604.4 31453.7 3513.9 3524.5 3591.9 3608.0 3626.8 251487.0 258140.0 258643.0 258822.0 259295.0 61499.7 62006.7 62252.7 62341.7 62646.7 38004.6 38984.8 39085.4 65577.7 66114.3 15876.2 15923.3 15934.2 16039.5 16194.8 12126.2 12159.8 12309.2 12331.9 12359.7 21127.8 21239.6 21287.1 21291.0 21340.1 7865.4 7978.5 8025.8 8278.9 8334.3 917.6 976.6 989.4 990.8 1043.2 28084.4 28993.9 29024.3 29387.4 29517.3 1035.4 1045.6 1049.4 1092.3 1114.0 15269.7 15457.8 15776.7 15848.4 16097.8 358255.0 364686.0 365246.0 365423.0 366130.0 51678.2 52980.5 53074.0 53160.2 53177.0 1272.5 1280.5 1304.3 1311.4 1331.6 27968.4 28479.4 28648.6 28747.7 29454.7 45184.3 45408.0 45598.5 45679.5 46063.5 305546.0 305667.0 306244.0 307248.0 307536.0 26345.2 26602.7 26675.0 26795.7 26854.9 44916.6 45131.8 45901.0 45902.3 45927.0 37186.4 37927.4 37992.8 38217.6 38838.6 36855.8 37471.3 37786.6 38246.6 38523.0 32620.5 33076.5 38200.6 38713.0 39323.0 33098.8 34216.8 34653.3 34836.5 35095.8 25827.7 26236.0 26633.7 26819.2 27005.7 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#2] jquery.html Cycles:180 Average:24478.00 Median:4920.84 stddev:67311.92 (1367.9%) stddev-sans-first:67476.42 17:58:10 INFO - PROCESS | 23069 | Values: 377.8 378.9 379.2 393.8 394.7 16604.9 17425.4 17858.7 18211.8 18241.3 15628.8 15738.5 15867.9 16008.8 16144.8 5105.8 5269.4 5296.1 5297.9 5301.1 3609.6 5689.5 5989.6 5997.9 6122.3 5508.9 5989.5 6039.9 6075.1 6077.5 5751.5 5861.2 5888.2 5893.1 5915.3 4567.3 4870.5 4906.5 4935.2 4961.1 12478.3 12497.8 12818.2 12910.6 12917.3 1924.1 1957.4 1982.9 2122.8 2169.7 9160.3 9530.8 9547.8 9629.1 9738.3 1705.3 1745.3 1803.8 1942.7 1958.8 68963.7 69993.3 71709.0 72257.0 72409.6 9378.7 9661.7 9702.9 9712.8 9874.6 12954.9 13092.7 13136.5 13565.7 13591.5 7043.8 7052.9 7108.3 7201.7 7230.3 7178.3 7253.7 7301.3 7389.0 7440.7 4039.9 4054.5 4061.6 4266.6 4549.1 1681.7 2913.3 3057.7 3335.6 3496.3 830.8 946.1 951.8 976.8 986.7 16529.8 17082.2 17283.4 17442.9 17601.4 910.4 914.9 926.9 935.6 989.0 9573.8 9657.2 9750.0 9786.7 9911.0 259971.0 427411.0 436303.0 439141.0 443189.0 49809.0 61699.7 88595.0 88727.1 89833.6 1004.9 1009.8 1023.6 1027.4 1029.2 15183.7 15340.8 15351.2 15360.9 15586.8 35432.5 35833.0 35839.3 36311.8 36466.5 50557.2 52884.0 52912.7 53018.0 53097.2 7725.5 7818.9 8036.1 8048.4 8115.7 11407.5 12026.6 12218.9 12587.7 12901.9 9580.9 9894.9 9958.5 9981.0 10060.2 4845.6 8913.6 9979.3 10109.8 10596.2 9647.3 10789.9 10863.5 10863.7 11114.3 7972.7 8067.2 8192.6 8265.4 8271.5 8026.4 10255.4 10279.5 10377.6 10532.0 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#3] mootools.html Cycles:180 Average:5056.04 Median:5454.79 stddev:2733.80 (50.1%) stddev-sans-first:2728.50 17:58:10 INFO - PROCESS | 23069 | Values: 1512.6 1518.2 1716.7 1844.4 1856.0 6623.9 7288.2 7358.6 7898.5 7931.6 7505.7 7738.5 7749.8 7769.5 7775.6 2250.0 2280.3 2281.5 2286.7 2290.5 2181.8 2218.4 2256.9 2259.3 2262.8 2180.9 2197.9 2209.9 2221.0 2262.9 2149.0 2155.7 2167.6 2176.3 2179.3 2139.0 2158.4 2158.4 2162.7 2163.1 7613.6 7619.9 7651.8 7655.4 7656.9 4481.0 4498.6 4677.4 4697.4 4711.4 2881.9 2992.4 3018.1 3020.1 3023.5 923.9 941.2 968.2 972.7 983.4 10267.2 10391.7 10407.9 10429.5 10448.8 4033.2 4137.3 4155.6 4162.5 4203.5 8282.6 8303.3 8306.4 8334.3 8370.2 4485.5 4566.0 4597.0 4598.2 4660.8 3725.1 4176.9 4255.1 4344.9 4361.0 3349.4 3372.2 3432.2 3468.0 3477.8 1013.1 1018.3 1029.4 1033.9 1042.6 789.0 914.3 937.1 950.6 952.9 5291.8 5371.4 5435.0 5590.9 5607.4 860.2 912.0 954.9 960.7 961.1 3609.0 3677.7 3780.9 3788.2 3788.3 8860.5 9151.2 9186.9 9204.4 9221.3 9120.8 9131.8 9204.0 9217.7 9235.4 7204.4 7355.6 7359.9 7369.3 7378.3 5230.8 5345.5 5349.4 5474.6 5523.8 7962.4 8562.1 8576.5 8594.1 8695.4 8241.6 8504.1 8536.0 8617.0 8683.5 5749.9 6504.1 6723.8 6725.3 6893.5 7434.2 7454.2 7460.3 7481.9 7518.2 6647.7 6876.2 6888.3 6941.6 6977.5 6678.8 6735.4 6747.8 6768.1 6794.7 5945.4 6159.3 6247.5 6267.3 6271.7 4506.5 4565.2 4607.6 4608.6 4697.1 4395.6 4474.2 4483.8 4489.0 4566.3 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#4] prototype.html Cycles:180 Average:4174.34 Median:4744.67 stddev:1213.75 (25.6%) stddev-sans-first:1181.81 17:58:10 INFO - PROCESS | 23069 | Values: 300.2 310.5 314.8 318.3 319.2 4674.9 4771.5 4794.7 4901.6 4915.4 4826.4 4827.8 4827.8 4830.7 4833.6 3834.9 3839.2 3839.5 3842.5 3844.2 3680.8 3841.5 3842.7 3850.2 3861.9 3745.9 3766.2 3816.1 3822.7 3831.3 3761.9 3775.5 3793.1 3793.8 3804.0 3161.8 3271.6 3299.7 3372.9 3395.9 4617.0 4619.9 4627.4 4633.4 4646.3 4212.9 4226.3 4230.9 4234.4 4256.5 4890.6 4968.2 4995.0 4997.8 5004.1 3555.7 3566.8 3569.8 3582.0 3586.2 5208.6 5228.9 5242.6 5247.2 5271.9 3651.7 3664.7 3670.3 3684.5 3694.5 3584.3 3695.9 3698.7 3701.0 3715.8 4231.8 4260.3 4273.6 4274.8 4276.5 5031.6 5042.1 5051.9 5054.4 5058.6 1179.6 1212.6 1225.5 1237.9 1250.5 838.3 851.5 861.2 864.8 868.0 4289.6 4295.5 4301.0 4303.7 4308.7 5006.9 5009.5 5012.4 5025.2 5036.3 4263.7 4278.8 4280.0 4285.9 4296.3 2499.0 2631.2 2631.4 2644.8 2664.7 4651.2 4712.9 4719.4 4758.4 4766.2 5034.0 5072.2 5080.9 5098.5 5108.8 4548.4 4897.7 4928.0 4942.6 4949.2 5237.4 5245.8 5254.0 5266.3 5267.8 4824.3 5093.8 5137.7 5146.8 5153.5 4899.7 4909.4 4929.6 4939.3 4970.7 3821.5 3845.1 3861.7 3869.1 3870.2 4730.9 5237.7 5243.8 5246.6 5254.0 5086.9 5088.5 5092.2 5099.0 5106.5 5077.1 5080.8 5089.9 5093.1 5109.9 4893.0 4999.8 5018.9 5021.2 5037.8 5075.3 5106.0 5116.4 5137.4 5148.8 4977.1 4984.2 4985.6 4988.2 4994.2 17:58:10 INFO - PROCESS | 23069 | 17:58:10 INFO - PROCESS | 23069 | [#5] yui.html Cycles:180 Average:12394.78 Median:536.03 stddev:14147.32 (2639.3%) stddev-sans-first:14159.77 17:58:10 INFO - PROCESS | 23069 | Values: 705.5 713.7 756.8 781.6 787.5 12527.6 12672.7 13032.1 13198.9 13465.3 12799.8 12889.4 12911.5 12936.3 12962.5 676.5 863.4 863.5 875.2 888.6 867.0 874.4 874.6 875.1 875.2 915.5 916.0 918.5 921.0 922.2 902.4 903.5 907.8 909.7 913.4 672.7 675.4 677.7 677.9 680.7 12274.9 12331.9 12365.6 12366.6 12446.5 12492.9 12546.4 12563.2 12661.1 13146.9 9986.5 10082.9 10278.6 10319.3 10447.6 3329.1 3411.7 3418.3 3515.9 3522.1 43815.1 43891.1 43910.6 43925.0 44085.3 9739.4 9868.7 9992.4 10007.3 10294.3 17252.4 17470.1 18265.7 18403.4 18441.6 6769.1 6849.6 6859.2 6880.4 6970.3 3805.5 3807.3 3820.2 3865.5 3872.6 2845.5 2920.0 2921.4 2926.2 2929.4 524.6 525.9 530.0 532.2 539.9 469.5 528.3 617.1 631.5 633.3 7209.8 7220.5 7322.2 7325.7 7360.2 515.2 597.5 604.0 614.3 620.6 3530.8 3583.7 3592.8 3673.8 3691.9 49485.3 50833.7 51515.5 51765.2 51961.0 45113.0 45302.3 45732.8 46266.5 46588.8 42322.8 42759.8 42760.0 43245.4 43353.3 7051.0 7158.1 7159.3 7175.4 7312.4 28092.2 29097.3 29238.0 29282.9 29571.6 34856.7 37203.1 37522.6 37823.2 37923.2 9227.6 9292.7 9565.5 9631.6 9678.0 9500.0 9767.0 9822.5 9823.0 10060.9 9554.4 9690.8 9691.7 9782.2 9891.2 9584.7 9615.9 9738.5 9758.4 10099.8 9606.8 9677.1 9814.7 9847.0 10032.9 8189.5 8274.3 8322.5 8437.5 8607.6 8417.0 8452.9 8587.7 8714.7 8732.3 17:58:10 INFO - PROCESS | 23069 | -------- Summary: end -------- 17:58:10 INFO - PROCESS | 23069 | 17:58:11 INFO - TEST-INFO | 23069: exit 0 17:58:11 INFO - TEST-OK | dromaeo_css | took 1115681ms 17:58:11 INFO - TEST-START | kraken 17:58:11 INFO - operating with platform_type : linux_ 17:58:11 INFO - Initialising browser for kraken test... 17:58:11 INFO - TEST-INFO | started process 23305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmjmpU/profile http://localhost:58312/getInfo.html) 17:58:15 INFO - PROCESS | 23305 | 17:58:15 INFO - PROCESS | 23305 | (process:23371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:58:16 INFO - PROCESS | 23305 | __metrics Screen width/height:1600/1200 17:58:16 INFO - PROCESS | 23305 | colorDepth:24 17:58:16 INFO - PROCESS | 23305 | Browser inner width/height: 1024/697 17:58:16 INFO - PROCESS | 23305 | __metrics 17:58:16 ERROR - PROCESS | 23305 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:58:17 INFO - TEST-INFO | 23305: exit 0 17:58:17 INFO - Browser initialized. 17:58:17 INFO - Running cycle 1/1 for kraken test... 17:58:17 INFO - TEST-INFO | started process 23422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmjmpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:19 INFO - PROCESS | 23422 | 17:58:19 INFO - PROCESS | 23422 | (process:23485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:58:29 INFO - PROCESS | 23422 | RSS: Main: 164974592 17:58:29 INFO - PROCESS | 23422 | 17:58:32 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58312/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:33 INFO - PROCESS | 23422 | RSS: Main: 168865792 17:58:33 INFO - PROCESS | 23422 | 17:58:36 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58312/tests/kraken/driver.html?testName=audio-dft) 17:58:36 INFO - PROCESS | 23422 | RSS: Main: 168857600 17:58:36 INFO - PROCESS | 23422 | 17:58:39 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58312/tests/kraken/driver.html?testName=audio-fft) 17:58:40 INFO - PROCESS | 23422 | RSS: Main: 164204544 17:58:40 INFO - PROCESS | 23422 | 17:58:42 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58312/tests/kraken/driver.html?testName=audio-oscillator) 17:58:43 INFO - PROCESS | 23422 | RSS: Main: 164610048 17:58:43 INFO - PROCESS | 23422 | 17:58:45 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58312/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:46 INFO - PROCESS | 23422 | RSS: Main: 164859904 17:58:46 INFO - PROCESS | 23422 | 17:58:49 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58312/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:49 INFO - PROCESS | 23422 | RSS: Main: 164954112 17:58:49 INFO - PROCESS | 23422 | 17:58:53 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58312/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:53 INFO - PROCESS | 23422 | RSS: Main: 163581952 17:58:53 INFO - PROCESS | 23422 | 17:58:56 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58312/tests/kraken/driver.html?testName=json-parse-financial) 17:58:57 INFO - PROCESS | 23422 | RSS: Main: 163856384 17:58:57 INFO - PROCESS | 23422 | 17:58:59 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58312/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:59 INFO - PROCESS | 23422 | RSS: Main: 163946496 17:58:59 INFO - PROCESS | 23422 | 17:59:01 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:02 INFO - PROCESS | 23422 | RSS: Main: 163930112 17:59:02 INFO - PROCESS | 23422 | 17:59:04 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:05 INFO - PROCESS | 23422 | RSS: Main: 165330944 17:59:05 INFO - PROCESS | 23422 | 17:59:08 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:08 INFO - PROCESS | 23422 | RSS: Main: 164298752 17:59:08 INFO - PROCESS | 23422 | 17:59:11 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:12 INFO - PROCESS | 23422 | RSS: Main: 164519936 17:59:12 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | Cycle 1(1): loaded http://localhost:58312/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58312/tests/kraken/driver.html?testName=ai-astar) 17:59:14 INFO - PROCESS | 23422 | RSS: Main: 165982208 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | __start_tp_report 17:59:14 INFO - PROCESS | 23422 | _x_x_mozilla_page_load 17:59:14 INFO - PROCESS | 23422 | _x_x_mozilla_page_load_details 17:59:14 INFO - PROCESS | 23422 | |i|pagename|runs| 17:59:14 INFO - PROCESS | 23422 | |0;ai-astar;113;114;106;115;113;113;109;114;114;116 17:59:14 INFO - PROCESS | 23422 | |1;audio-beat-detection;154;139;156;179;136;163;160;132;203;140 17:59:14 INFO - PROCESS | 23422 | |2;audio-dft;162;166;164;164;167;163;164;164;164;164 17:59:14 INFO - PROCESS | 23422 | |3;audio-fft;76;75;76;172;77;75;75;76;154;77 17:59:14 INFO - PROCESS | 23422 | |4;audio-oscillator;94;93;155;95;95;94;144;95;94;147 17:59:14 INFO - PROCESS | 23422 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;117;118;118 17:59:14 INFO - PROCESS | 23422 | |6;imaging-darkroom;146;147;148;148;147;147;147;147;148;147 17:59:14 INFO - PROCESS | 23422 | |7;imaging-desaturate;94;95;96;95;96;95;96;96;97;96 17:59:14 INFO - PROCESS | 23422 | |8;json-parse-financial;68;70;68;68;67;69;67;83;67;66 17:59:14 INFO - PROCESS | 23422 | |9;json-stringify-tinderbox;64;65;64;65;64;64;65;65;64;64 17:59:14 INFO - PROCESS | 23422 | |10;stanford-crypto-aes;84;81;84;83;85;84;85;85;83;84 17:59:14 INFO - PROCESS | 23422 | |11;stanford-crypto-ccm;134;137;133;136;134;137;139;153;164;140 17:59:14 INFO - PROCESS | 23422 | |12;stanford-crypto-pbkdf2;183;173;175;172;175;172;174;174;174;172 17:59:14 INFO - PROCESS | 23422 | |13;stanford-crypto-sha256-iterative;71;69;69;68;68;68;68;68;67;66 17:59:14 INFO - PROCESS | 23422 | __end_tp_report 17:59:14 INFO - PROCESS | 23422 | __start_cc_report 17:59:14 INFO - PROCESS | 23422 | _x_x_mozilla_cycle_collect,913 17:59:14 INFO - PROCESS | 23422 | __end_cc_report 17:59:14 INFO - PROCESS | 23422 | __startTimestamp1462582754303__endTimestamp 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | ------- Summary: start ------- 17:59:14 INFO - PROCESS | 23422 | Number of tests: 14 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:2.98 (2.6%) stddev-sans-first:3.16 17:59:14 INFO - PROCESS | 23422 | Values: 113.0 114.0 106.0 115.0 113.0 113.0 109.0 114.0 114.0 116.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:158.00 stddev:21.93 (13.9%) stddev-sans-first:23.24 17:59:14 INFO - PROCESS | 23422 | Values: 154.0 139.0 156.0 179.0 136.0 163.0 160.0 132.0 203.0 140.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:1.40 (0.9%) stddev-sans-first:1.24 17:59:14 INFO - PROCESS | 23422 | Values: 162.0 166.0 164.0 164.0 167.0 163.0 164.0 164.0 164.0 164.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#3] audio-fft Cycles:10 Average:93.30 Median:76.00 stddev:36.99 (48.7%) stddev-sans-first:38.70 17:59:14 INFO - PROCESS | 23422 | Values: 76.0 75.0 76.0 172.0 77.0 75.0 75.0 76.0 154.0 77.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:94.00 stddev:26.41 (28.1%) stddev-sans-first:27.32 17:59:14 INFO - PROCESS | 23422 | Values: 94.0 93.0 155.0 95.0 95.0 94.0 144.0 95.0 94.0 147.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:59:14 INFO - PROCESS | 23422 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 17:59:14 INFO - PROCESS | 23422 | Values: 146.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.67 17:59:14 INFO - PROCESS | 23422 | Values: 94.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 97.0 96.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:68.00 stddev:4.95 (7.3%) stddev-sans-first:5.22 17:59:14 INFO - PROCESS | 23422 | Values: 68.0 70.0 68.0 68.0 67.0 69.0 67.0 83.0 67.0 66.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 17:59:14 INFO - PROCESS | 23422 | Values: 64.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 64.0 64.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.30 17:59:14 INFO - PROCESS | 23422 | Values: 84.0 81.0 84.0 83.0 85.0 84.0 85.0 85.0 83.0 84.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:138.00 stddev:9.98 (7.2%) stddev-sans-first:10.28 17:59:14 INFO - PROCESS | 23422 | Values: 134.0 137.0 133.0 136.0 134.0 137.0 139.0 153.0 164.0 140.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:3.24 (1.9%) stddev-sans-first:1.24 17:59:14 INFO - PROCESS | 23422 | Values: 183.0 173.0 175.0 172.0 175.0 172.0 174.0 174.0 174.0 172.0 17:59:14 INFO - PROCESS | 23422 | 17:59:14 INFO - PROCESS | 23422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.32 (1.9%) stddev-sans-first:0.93 17:59:14 INFO - PROCESS | 23422 | Values: 71.0 69.0 69.0 68.0 68.0 68.0 68.0 68.0 67.0 66.0 17:59:14 INFO - PROCESS | 23422 | -------- Summary: end -------- 17:59:14 INFO - PROCESS | 23422 | 17:59:15 INFO - TEST-INFO | 23422: exit 0 17:59:15 INFO - TEST-OK | kraken | took 64142ms 17:59:15 INFO - SUITE-END | took 1179s 17:59:15 INFO - Completed test suite (00:19:39) 17:59:15 INFO - javascript benchmark 17:59:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.753878381554, 2638.1953504181224, 2642.062067965873, 2658.5214661360947, 2666.626672265882, 4529.7282163070195, 4601.240795268781, 4632.212523870941, 4725.8582242532775, 4761.54765297297, 4574.153781550415, 4611.700239484431, 4634.536546345364, 4642.489326174118, 4660.6504512161555, 4265.040365917667, 4289.142171565683, 4369.4756629204385, 4375.628071613916, 4397.450318710161, 4312.288472402066, 4315.546867578906, 4368.148211098837, 4381.07997320563, 4384.671149663772, 4202.3696445533415, 4276.166147601219, 4285.314349704033, 4310.267254566731, 4362.716423432466, 4298.140371925628, 4309.547497512747, 4317.892052698676, 4320.330348795942, 4364.585364390377, 4331.913361732779, 4337.175936572073, 4346.174226896879, 4358.259095953664, 4388.780560971971, 4608.8386906458445, 4612.53874612536, 4677.0178262564905, 4678.6257099432305, 4685.273782563674, 5062.341895553554, 5088.313077734532, 5101.13280742271, 5107.846764597031, 5140.974295128501, 5000.0999820032375, 5086.338775959139, 5119.744012799382, 5120.15517439622, 5130.230465430178, 4692.976535117336, 4711.575958163782, 4714.66997310185, 4728.361671174416, 4761.928571071437, 5164.664296820694, 5167.793288268427, 5176.7411629418375, 5178.741062946838, 5186.792528298825, 4832.975835120802, 4833.299171620095, 4853.02939412119, 4951.801927922915, 4995.925061124086, 4962.454130045692, 4966.1309270877455, 4970.030843985388, 4984.651074424828, 5005.299258103868, 4874.2201247800185, 4945.134601444733, 5012.147934851084, 5014.749262536931, 5074.898502029939, 4832.347633069561, 4971.130052240844, 4978.054169707744, 4997.275395067695, 5011.674241174312, 4311.568843115726, 4321.870343889688, 4329.848455304049, 4339.956600433955, 4369.563043695605, 3755.586885442599, 3756.962430375716, 3769.6607305342104, 3780.092777733379, 3796.468494410785, 4269.847141271839, 4298.849540266138, 4318.050028993616, 4366.6506679465565, 4369.890752731207, 5013.749312534359, 5017.774200161001, 5053.0399224147295, 5064.11378008847, 5088.389393272831, 4321.40110639772, 4352.1513304905875, 4352.2818734909015, 4380.8685739427865, 4412.867613971586, 4427.070315233773, 4505.7296562206375, 4520.254158063883, 4561.270196768501, 4575.336576196433, 4768.642351823558, 4781.474037855833, 4801.351817504592, 4806.687565308243, 4807.399075115611, 5059.139946209227, 5084.567811736044, 5087.592992560512, 5091.974540127276, 5097.133487307093, 4584.358189853357, 4718.528147185254, 4740.288956656529, 4756.262779269219, 4808.711477311373, 4974.0797952378925, 4994.350734404504, 5016.147254966591, 5022.045811295842, 5048.545630893237, 5065.088284108896, 5069.214271787879, 5071.239314102767, 5071.568916641979, 5129.666571672829, 4691.390119284471, 4735.384400027974, 4805.231163014041, 4843.539863712942, 4873.7806798694855, 4800.495947925418, 4806.110869489155, 4823.3729615149805, 4828.106800241966, 4854.611631069577, 4786.0, 4799.7120172788345, 4807.399075115611, 4815.085133824562, 4822.107910036654, 4810.278458231293, 4887.218045112765, 4927.063857867137, 4933.58064564516, 4958.330625365529, 4794.113089078532, 4840.540148685869, 4855.053264613366, 4855.320255164351, 4901.068796928572], "value": 4616.457522216903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4838941731279, 605.5186127029009, 616.7286393986645, 636.9968150159249, 641.1312671330351, 35432.114197145085, 39365.40951885724, 39486.60513394865, 39645.60354396455, 39666.80166599163, 40120.39819402711, 40422.19155616886, 40856.79571602145, 40895.38656920149, 40907.59092409075, 7828.569428681434, 7948.880766788503, 7952.920470795305, 7959.681612735483, 7969.083555391117, 7799.142094369615, 7839.059312882462, 7858.803529911741, 7879.684812607489, 7913.683452661915, 7873.881891771599, 7882.645280962371, 7914.604269786517, 7941.64262608184, 7961.243681850215, 7849.960750196241, 7873.0, 7882.369410447208, 7886.605669716549, 7903.1701671324545, 7805.1804560520895, 7832.56920869352, 7853.371730261565, 7857.567833769141, 7883.960580197062, 31344.21639459009, 38798.224035519415, 39055.60944390548, 39156.412653810214, 39167.60832391697, 3164.841757912095, 3166.224275052604, 3288.4574045282498, 3328.3509715605223, 3440.0539851540775, 28545.287282762893, 28751.71248287511, 29815.70184298151, 30604.387912241855, 31453.68546314553, 3513.9121521962156, 3524.4889491023914, 3591.90556492412, 3607.981960090209, 3626.782393056425, 251487.0, 258140.0, 258643.0, 258822.0, 259295.0, 61499.6925015381, 62006.68996655078, 62252.688736556935, 62341.688291558254, 62646.68676656679, 38004.61995380066, 38984.805075975004, 39085.41371879424, 65577.67211164009, 66114.33885661082, 15876.206189690469, 15923.283452244677, 15934.203289835461, 16039.518814435585, 16194.75707864383, 12126.211796233216, 12159.75680486403, 12309.199902006341, 12331.938340308421, 12359.69100772488, 21127.788722112582, 21239.575208495742, 21287.148514059263, 21291.0, 21340.146394144373, 7865.410094242955, 7978.481398709066, 8025.759227223192, 8278.875816862752, 8334.291585215324, 917.5733284022962, 976.6191185437685, 989.4261328429494, 990.8117457683018, 1043.2071625564627, 28084.43831123366, 28993.91502933032, 29024.274393140342, 29387.412251754846, 29517.26206844803, 1035.3994683083793, 1045.6340280901622, 1049.4280617063719, 1092.251807511857, 1113.9721506962392, 15269.694606108038, 15457.84542154564, 15776.68446631061, 15848.44530441429, 16097.758533622005, 358255.0, 364686.0, 365246.0, 365423.0, 366130.0, 51678.22482662763, 52980.47019529755, 53074.0, 53160.20259696108, 53177.0, 1272.4910035985495, 1280.475005247844, 1304.3282709404664, 1311.3902035553322, 1331.5872079655144, 27968.44063118767, 28479.43041139124, 28648.57027144553, 28747.71252287534, 29454.705452945196, 45184.32223516716, 45408.0, 45598.54401455943, 45679.543204567526, 46063.539364605924, 305546.0, 305667.0, 306244.0, 307248.0, 307536.0, 26345.20964371072, 26602.733972660026, 26675.0, 26795.732042679323, 26854.865725671247, 44916.55083449124, 45131.77434112808, 45901.0, 45902.31146532871, 45927.0, 37186.44220336643, 37927.43108853425, 37992.810035949646, 38217.617823821405, 38838.6116138835, 36855.81572092122, 37471.250574988895, 37786.62213377831, 38246.617533824305, 38523.0, 32620.510692340107, 33076.503852442715, 38200.61799381971, 38713.0, 39323.0, 33098.83450582732, 34216.82891585526, 34653.306933861684, 34836.477452837724, 35095.824520877235, 25827.741722582534, 26236.0, 26633.733662663126, 26819.195424137306, 27005.719278735527], "value": 18313.429228829395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7752237418735, 378.88444024572505, 379.2131327495447, 393.75193628014347, 394.6901682179488, 16604.920680155796, 17425.390111346107, 17858.73211901821, 18211.817881821178, 18241.270349186034, 15628.84371156288, 15738.527844164664, 15867.920660396681, 16008.83991160088, 16144.75782863255, 5105.821296254632, 5269.394019687727, 5296.09966305727, 5297.920531192035, 5301.098813201765, 3609.620989796073, 5689.51639110674, 5989.610675306091, 5997.88004239915, 6122.295935967376, 5508.889822203553, 5989.460948514633, 6039.879202415949, 6075.058365953262, 6077.544184186182, 5751.511121554673, 5861.150133230701, 5888.205092312547, 5893.14549390336, 5915.319738230094, 4567.269236922077, 4870.488598697157, 4906.460289368167, 4935.210366341368, 4961.107000739866, 12478.251304921734, 12497.75004499914, 12818.230906145567, 12910.612681619567, 12917.289549074798, 1924.1437560285679, 1957.354073155855, 1982.8611997160206, 2122.8089471947446, 2169.739631244245, 9160.312976526788, 9530.809383812355, 9547.761305967406, 9629.133377996013, 9738.269629777724, 1705.2752580153385, 1745.3280487012464, 1803.7564928734716, 1942.6692715489935, 1958.8139126782933, 68963.65518172427, 69993.30006699919, 71709.0, 72257.0, 72409.6379518099, 9378.67174648884, 9661.71014869555, 9702.9029709702, 9712.757181070388, 9874.605015799287, 12954.870451295366, 13092.738145237232, 13136.474541018444, 13565.660858478617, 13591.52429664957, 7043.788686339418, 7052.894206586905, 7108.324709152622, 7201.747938822116, 7230.349268565854, 7178.318059784312, 7253.673584688596, 7301.342879140797, 7389.0, 7440.73957411488, 4039.939400908989, 4054.533728621246, 4061.593840615974, 4266.573342665771, 4549.135664223787, 1681.6636672665516, 2913.344497488091, 3057.7400920921973, 3335.566376371105, 3496.283261931298, 830.7538691962056, 946.1012038563255, 951.8191543606692, 976.8192884316425, 986.7237173591406, 16529.752053719203, 17082.23129959155, 17283.395081172097, 17442.91278543599, 17601.383951561635, 910.3763921713647, 914.9085091490798, 926.9212116970133, 935.6023689931752, 989.0, 9573.808523829624, 9657.179139773058, 9750.0, 9786.706398808046, 9910.950445247727, 259971.0, 427411.0, 436303.0, 439141.0, 443189.0, 49809.0, 61699.691501542206, 88595.0, 88727.11272887318, 89833.55083224672, 1004.914582260516, 1009.7828966772179, 1023.6059117239768, 1027.3630349183554, 1029.2126523209602, 15183.696326073637, 15340.846591534388, 15351.23243837826, 15360.923195383952, 15586.766198506804, 35432.46851297181, 35833.0, 35839.28321433609, 36311.81844090763, 36466.45300320444, 50557.241641374676, 52884.0, 52912.735436322575, 53018.0, 53097.20354194613, 7725.49784264021, 7818.882716759367, 8036.1160272368825, 8048.356131509348, 8115.715949941724, 11407.543698251977, 12026.579069732517, 12218.938905305416, 12587.685307867376, 12901.870981290067, 9580.856287155837, 9894.851577226204, 9958.452285124098, 9980.950095249478, 10060.245481588763, 4845.63657725665, 8913.573828187458, 9979.251556133464, 10109.797804044025, 10596.15230781551, 9647.276454266099, 10789.892101078889, 10863.456827158452, 10863.728406789893, 11114.333140011626, 7972.681092756457, 8067.152948940511, 8192.631331590212, 8265.380096492907, 8271.54506502148, 8026.43814932949, 10255.384676919408, 10279.53742081623, 10377.584896604052, 10532.0], "value": 8319.961884464241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.56135720641, 1518.2181176694003, 1716.7253239481686, 1844.4282272495536, 1855.9721604175932, 6623.9006414903815, 7288.234735352791, 7358.595277259756, 7898.526088434691, 7931.643076061577, 7505.699772009113, 7738.535687858733, 7749.7675069748, 7769.456138070337, 7775.572343521104, 2250.03248603101, 2280.338701776483, 2281.452451411666, 2286.6798648189265, 2290.4502919299416, 2181.770914054025, 2218.389942765736, 2256.8645881247094, 2259.3334966185016, 2262.751097379287, 2180.90185941633, 2197.8681279123225, 2209.933701988943, 2221.0449506712107, 2262.9434264143447, 2148.957020859574, 2155.7305336832897, 2167.5881582499355, 2176.3253391448543, 2179.3461961411595, 2138.9786102138937, 2158.3740715192575, 2158.4495953531905, 2162.7296587926508, 2163.134746101556, 7613.581253031081, 7619.885701714478, 7651.846963060708, 7655.387568994467, 7656.885146722803, 4481.0, 4498.572635599613, 4677.415323084614, 4697.389339385858, 4711.363965864599, 2881.9135425937257, 2992.431438026768, 3018.109657650998, 3020.0939718084487, 3023.5313526403443, 923.8891333040011, 941.2187884056217, 968.2205824311427, 972.6790159247431, 983.3608154699431, 10267.229957753123, 10391.688249352532, 10407.947960260226, 10429.478526073743, 10448.843267350996, 4033.193361327746, 4137.317342638431, 4155.625993660585, 4162.501499460192, 4203.516595591485, 8282.58587070644, 8303.294219991369, 8306.377021723394, 8334.291585215204, 8370.204830541088, 4485.48416932057, 4565.977170114128, 4597.0346227291975, 4598.172328980749, 4660.790264438108, 3725.1059745660846, 4176.937345939813, 4255.085156691264, 4344.9131017380105, 4361.0, 3349.39710852049, 3372.2412457197424, 3432.1591210153674, 3468.0462872710204, 3477.756557040983, 1013.1135256650431, 1018.3177271228295, 1029.444100185906, 1033.8811036730722, 1042.6246551241547, 788.9566073865992, 914.264017465933, 937.1237892570468, 950.6245033211843, 952.9380590261611, 5291.761870715827, 5371.3822910365025, 5434.972825135849, 5590.91613625796, 5607.355154157242, 860.2064695110639, 911.9635214591342, 954.88063992001, 960.7309953212972, 961.0869673809908, 3609.0, 3677.687396571268, 3780.8865734028022, 3788.242351529705, 3788.299164654548, 8860.512671802984, 9151.222146117654, 9186.908130918606, 9204.355695101412, 9221.262299016063, 9120.81758364829, 9131.771705707277, 9204.033576474507, 9217.677381291622, 9235.353525253302, 7204.423646108299, 7355.59544225062, 7359.926400735924, 7369.299916507923, 7378.262173782578, 5230.764615592231, 5345.545628621455, 5349.358077030781, 5474.616776825584, 5523.834284971457, 7962.442629015914, 8562.143785621389, 8576.485410875368, 8594.140585941606, 8695.391322607356, 8241.629126689193, 8504.149585041447, 8536.0, 8617.0, 8683.478991260545, 5749.856253593526, 6504.089427480251, 6723.798286051427, 6725.260221375743, 6893.517453778188, 7434.182239953492, 7454.180040195466, 7460.328570428687, 7481.887771683538, 7518.173000969999, 6647.700853461509, 6876.17485901695, 6888.345607167311, 6941.618210998444, 6977.546459480118, 6678.83302917431, 6735.360140786617, 6747.797566073025, 6768.08630834831, 6794.66026698673, 5945.435183657545, 6159.322474527888, 6247.531435142473, 6267.310595834363, 6271.6550589718, 4506.481754598132, 4565.223911934912, 4607.5622815833785, 4608.5621865922685, 4697.107549565571, 4395.582419670126, 4474.239379305461, 4483.7982290797645, 4489.0, 4566.292224705176], "value": 4127.302851101577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2074523258598, 310.492345015899, 314.7906642083015, 318.28862492329637, 319.2147317598707, 4674.85975420737, 4771.522847715227, 4794.68834525756, 4901.58336541394, 4915.434725006621, 4826.420829500456, 4827.78274977626, 4827.78274977626, 4830.661853670244, 4833.589144922686, 3834.9041273968096, 3839.1937693084487, 3839.539255289369, 3842.538895332557, 3844.2119365529998, 3680.7791532508, 3841.519810023747, 3842.6733727633186, 3850.210706805098, 3861.942070868939, 3745.8876233712895, 3766.171442282707, 3816.0841398064404, 3822.6750726188307, 3831.3486707259694, 3761.946654936622, 3775.546934367866, 3793.1275806564645, 3793.829277682497, 3803.9919421353366, 3161.7944833585975, 3271.6237632672073, 3299.7195238404765, 3372.9156771080675, 3395.8811441599423, 4617.007343421181, 4619.907601847978, 4627.444706635191, 4633.374494443241, 4646.279826626878, 4212.873613791591, 4226.3026600610865, 4230.8519201827785, 4234.3860140279485, 4256.5105012923605, 4890.584300334476, 4968.205087186033, 4995.0, 4997.750112494397, 5004.074246264453, 3555.715542756573, 3566.821658917044, 3569.785812851237, 3581.982090089559, 3586.211033572636, 5208.635395522315, 5228.92156617651, 5242.55438287746, 5247.16045432729, 5271.894562108736, 3651.653092956165, 3664.6518580734787, 3670.284294562535, 3684.5394325709285, 3694.538182727159, 3584.336897673939, 3695.9445608315896, 3698.7041036716996, 3700.965208529034, 3715.758475699071, 4231.767252801125, 4260.339647354665, 4273.594008569181, 4274.764887931194, 4276.48682158143, 5031.622628302819, 5042.117629414838, 5051.913838524735, 5054.368203974504, 5058.570021548209, 1179.55177032727, 1212.6483319837325, 1225.5281716539196, 1237.888590026902, 1250.5060501102014, 838.2581415447252, 851.4805968359295, 861.1560670542904, 864.8356812205661, 867.9566021698889, 4289.635380992589, 4295.5060168080445, 4300.956990430118, 4303.720258183208, 4308.655307575386, 5006.874828129253, 5009.524095210949, 5012.373453318335, 5025.221090730943, 5036.345275114285, 4263.720883734867, 4278.7860606969525, 4279.97860010698, 4285.914281714348, 4296.334068219431, 2498.9875050624632, 2631.1580294306023, 2631.4210873607776, 2644.801639877017, 2664.653595032672, 4651.162790697639, 4712.858614241578, 4719.386479757678, 4758.429718192988, 4766.1659209638865, 5033.968036552498, 5072.188449848007, 5080.949190508121, 5098.5411312982005, 5108.795648174031, 4548.385967894292, 4897.706137631753, 4927.975360123177, 4942.604591632733, 4949.232868905326, 5237.407483295793, 5245.790168393374, 5254.0, 5266.34170728659, 5267.841964741064, 4824.300476430968, 5093.784203871328, 5137.691738495702, 5146.76839542214, 5153.45888681698, 4899.657024008286, 4909.361782968192, 4929.630277729113, 4939.259111133215, 4970.701757894538, 3821.541415030214, 3845.0777409168672, 3861.6524512793985, 3869.0714228584375, 3870.187260675177, 4730.905381892412, 5237.659552129099, 5243.764030618708, 5246.632735708464, 5254.0, 5086.923696144487, 5088.516590923857, 5092.185250359925, 5098.980203959297, 5106.514881086291, 5077.136886729191, 5080.771365288497, 5089.898202035864, 5093.108705976365, 5109.9233511498105, 4892.951070489249, 4999.800007999639, 5018.924716129334, 5021.171506701354, 5037.823676171316, 5075.3402057732255, 5105.974470127626, 5116.386033675983, 5137.357830271216, 5148.841510660071, 4977.104121258209, 4984.2025275955675, 4985.5762260208285, 4988.201887697951, 4994.1509943309], "value": 3790.192200125216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.4673721340387, 713.7252157919199, 756.8486302739452, 781.6209138567793, 787.4684587903164, 12527.624171274876, 12672.68318292042, 13032.087753857233, 13198.868011319884, 13465.259410732406, 12799.808002879941, 12889.355532223399, 12911.548095816648, 12936.28850413227, 12962.48150073996, 676.4588329336535, 863.4085651328828, 863.4517081653148, 875.155474966657, 888.6045709659204, 866.9826603467927, 874.4054043250619, 874.5845723281423, 875.0986483921571, 875.2429148786285, 915.5330781301551, 915.9771005724876, 918.5315489100574, 920.9815803683922, 922.1976880114277, 902.4224496322327, 903.4759839293195, 907.7549061753323, 909.7316291693966, 913.4108500017452, 672.7275453441364, 675.3955210086945, 677.7153595489906, 677.9254282029023, 680.6664734280216, 12274.877251227552, 12331.938340308241, 12365.567205147776, 12366.62900112998, 12446.502139914393, 12492.937535312356, 12546.435410406553, 12563.18339307942, 12661.113722039461, 13146.86853131466, 9986.465632194826, 10082.949585252027, 10278.640247591298, 10319.329243599143, 10447.634332798316, 3329.1011426914597, 3411.710004649608, 3418.282160746246, 3515.9472607910902, 3522.119470132467, 43815.12369752587, 43891.12217755627, 43910.56089439129, 43925.0, 44085.33871991923, 9739.41563506192, 9868.703938881845, 9992.350497217658, 10007.299489035844, 10294.330868493675, 17252.396166134124, 17470.126493675267, 18265.726014109798, 18403.355882544045, 18441.631167376847, 6769.120014398195, 6849.623270720059, 6859.176898772179, 6880.415164710956, 6970.302969703091, 3805.486259355007, 3807.333716599584, 3820.2168555446624, 3865.5168103987003, 3872.5933776953016, 2845.5304874695444, 2920.007197552842, 2921.415716856637, 2926.1514160893103, 2929.3701854101046, 524.5732893219637, 525.8632755483602, 529.9841004769863, 532.1857557936363, 539.8704310965419, 469.50925341065295, 528.3184691747603, 617.102116420607, 631.4884943196026, 633.3349982518338, 7209.819754506179, 7220.530665506725, 7322.231165727629, 7325.670344834495, 7360.190379058299, 515.2220147577185, 597.489146779506, 603.9939600604025, 614.265952187141, 620.6152185644929, 3530.7528473007155, 3583.7312201584987, 3592.7844329340323, 3673.7876500754687, 3691.90770230741, 49485.257721134214, 50833.74583127061, 51515.48484515182, 51765.2235216472, 51961.0, 45113.0, 45302.32046519305, 45732.77133614311, 46266.5373346269, 46588.7670561645, 42322.78838605787, 42759.786201069415, 42760.0, 43245.35131973023, 43353.34969975453, 7051.012858199959, 7158.141023077264, 7159.284071592799, 7175.390091842252, 7312.378447831994, 28092.157235282975, 29097.272568185967, 29238.0, 29282.853585731937, 29571.556426654046, 34856.65143348635, 37203.06992325214, 37522.624773751915, 37823.243535129695, 37923.24153516969, 9227.630894764134, 9292.72121836319, 9565.473898935625, 9631.614735410505, 9677.951610241904, 9499.952500237454, 9766.951165244129, 9822.5088745561, 9823.0, 10060.899391005996, 9554.42673439568, 9690.75773105678, 9691.70924872255, 9782.217422606032, 9891.159251463418, 9584.66453674146, 9615.9038409615, 9738.464384458923, 9758.414495130031, 10099.848502272618, 9606.759831004281, 9677.080677335642, 9814.65648702292, 9846.950765246127, 10032.899671003197, 8189.50862948225, 8274.29668478162, 8322.50064996102, 8437.451565648213, 8607.612657430305, 8417.0, 8452.915470845213, 8587.65649374018, 8714.738557843275, 8732.301415886841], "value": 5841.865210916489, "unit": "score"}], "name": "dromaeo_css", "value": 6329.293431209989, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 106.0, 115.0, 113.0, 113.0, 109.0, 114.0, 114.0, 116.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 139.0, 156.0, 179.0, 136.0, 163.0, 160.0, 132.0, 203.0, 140.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 164.0, 167.0, 163.0, 164.0, 164.0, 164.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 172.0, 77.0, 75.0, 75.0, 76.0, 154.0, 77.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 155.0, 95.0, 95.0, 94.0, 144.0, 95.0, 94.0, 147.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 68.0, 67.0, 69.0, 67.0, 83.0, 67.0, 66.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 84.0, 83.0, 85.0, 84.0, 85.0, 85.0, 83.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 133.0, 136.0, 134.0, 137.0, 139.0, 153.0, 164.0, 140.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 173.0, 175.0, 172.0, 175.0, 172.0, 174.0, 174.0, 174.0, 172.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1598.3000000000004, "alertThreshold": 2.0}]} 17:59:15 INFO - Return code: 0 17:59:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:59:15 ERROR - # TBPL SUCCESS # 17:59:15 INFO - Running post-action listener: _resource_record_post_action 17:59:15 INFO - ##### 17:59:15 INFO - ##### Finished run-tests step (success) 17:59:15 INFO - ##### 17:59:15 INFO - Running post-run listener: _resource_record_post_run 17:59:16 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 535572480; Read time: 104; Write time: 573288 17:59:16 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242352128; Read time: 0; Write time: 331972 17:59:16 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291631104; Read time: 104; Write time: 241244 17:59:16 INFO - Running post-run listener: _upload_blobber_files 17:59:16 INFO - Blob upload gear active. 17:59:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:16 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 17:59:16 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'] 17:59:16 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 17:59:17 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:59:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:18 INFO - (blobuploader) - INFO - Done attempting. 17:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:19 INFO - (blobuploader) - INFO - Done attempting. 17:59:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:19 INFO - Return code: 0 17:59:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03b8a76ecf12672d4264462b94df9112d2fd3fa21e7342cc16ddbcba65cfe95d7de3c45688b7eb74f151c238a896fa792c0606d87fcdc186fa20c9ca408e86d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76c81c4db1a343466447f5c208f378d4bb590b8d126a3ba9c61388b434e52bbd73f784a3337e42930c1b92c515095bc3f41315be18214c678e770fa664ce38d5"} 17:59:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:19 INFO - Contents: 17:59:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03b8a76ecf12672d4264462b94df9112d2fd3fa21e7342cc16ddbcba65cfe95d7de3c45688b7eb74f151c238a896fa792c0606d87fcdc186fa20c9ca408e86d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76c81c4db1a343466447f5c208f378d4bb590b8d126a3ba9c61388b434e52bbd73f784a3337e42930c1b92c515095bc3f41315be18214c678e770fa664ce38d5"} 17:59:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:19 INFO - Copying logs to upload dir... 17:59:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.283063 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-06 17:59:19.352751) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 17:59:19.356318) ========= 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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 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/03b8a76ecf12672d4264462b94df9112d2fd3fa21e7342cc16ddbcba65cfe95d7de3c45688b7eb74f151c238a896fa792c0606d87fcdc186fa20c9ca408e86d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76c81c4db1a343466447f5c208f378d4bb590b8d126a3ba9c61388b434e52bbd73f784a3337e42930c1b92c515095bc3f41315be18214c678e770fa664ce38d5"} build_url:https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/cY95jxuvS3et5mgvpMpgqQ/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/03b8a76ecf12672d4264462b94df9112d2fd3fa21e7342cc16ddbcba65cfe95d7de3c45688b7eb74f151c238a896fa792c0606d87fcdc186fa20c9ca408e86d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76c81c4db1a343466447f5c208f378d4bb590b8d126a3ba9c61388b434e52bbd73f784a3337e42930c1b92c515095bc3f41315be18214c678e770fa664ce38d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 17:59:19.388827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:59:19.389148) ========= 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=d2a8c569965ab8367867b893000001a1-1462580963.277578-1097418975 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 17:59:19.472993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 17:59:19.473352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 17:59:19.473662) ========= ========= Total master_lag: 0.19 =========