builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1460712138.48 results: success (0) buildid: 20160415014444 builduid: 53cbf33aba3b4b43a8b31ea0e7abbaf5 revision: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.478741) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.479242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.479598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.524595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.524925) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 02:22:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-15 02:22:19 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.643324) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.643660) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.693363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:18.693771) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d0c2f09a6285ad7a9f25fcb704de38c9c5168369 --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 d0c2f09a6285ad7a9f25fcb704de38c9c5168369 --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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 02:22:19,149 truncating revision to first 12 chars 2016-04-15 02:22:19,149 Setting DEBUG logging. 2016-04-15 02:22:19,149 attempt 1/10 2016-04-15 02:22:19,149 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d0c2f09a6285?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:22:19,617 unpacking tar archive at: fx-team-d0c2f09a6285/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743180 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.450372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.450832) ========= script_repo_revision: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.451425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.451896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:22:19.463558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-15 02:22:19.463865) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:22:19 INFO - MultiFileLogger online at 20160415 02:22:19 in /builds/slave/test 02:22:19 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 02:22:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:20 INFO - {'append_to_log': False, 02:22:20 INFO - 'base_work_dir': '/builds/slave/test', 02:22:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:22:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:20 INFO - 'branch': 'Fx-Team-Non-PGO', 02:22:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:20 INFO - 'config_files': ('talos/linux_config.py',), 02:22:20 INFO - 'default_actions': ('clobber', 02:22:20 INFO - 'read-buildbot-config', 02:22:20 INFO - 'download-and-extract', 02:22:20 INFO - 'populate-webroot', 02:22:20 INFO - 'create-virtualenv', 02:22:20 INFO - 'install', 02:22:20 INFO - 'run-tests'), 02:22:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:20 INFO - 'download_minidump_stackwalk': True, 02:22:20 INFO - 'download_symbols': 'ondemand', 02:22:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:20 INFO - 'installer_path': 'installer.exe', 02:22:20 INFO - 'log_level': 'info', 02:22:20 INFO - 'log_name': 'talos', 02:22:20 INFO - 'log_to_console': True, 02:22:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:22:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:22:20 INFO - 'opt_config_files': (), 02:22:20 INFO - 'pip_index': False, 02:22:20 INFO - 'sps_profile': False, 02:22:20 INFO - 'sps_profile_interval': 0, 02:22:20 INFO - 'suite': 'dromaeojs-e10s', 02:22:20 INFO - 'system_bits': '32', 02:22:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:20 INFO - 'title': 'talos-linux64-ix-022', 02:22:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:20 INFO - 'use_talos_json': True, 02:22:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:20 INFO - 'work_dir': 'build'} 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running clobber step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: clobber 02:22:20 INFO - rmtree: /builds/slave/test/build 02:22:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running read-buildbot-config step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: read_buildbot_config 02:22:20 INFO - Using buildbot properties: 02:22:20 INFO - { 02:22:20 INFO - "project": "", 02:22:20 INFO - "product": "firefox", 02:22:20 INFO - "script_repo_revision": "production", 02:22:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:22:20 INFO - "repository": "", 02:22:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:22:20 INFO - "buildid": "20160415014444", 02:22:20 INFO - "pgo_build": "False", 02:22:20 INFO - "basedir": "/builds/slave/test", 02:22:20 INFO - "buildnumber": 1155, 02:22:20 INFO - "slavename": "talos-linux64-ix-022", 02:22:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:22:20 INFO - "platform": "ubuntu64_hw", 02:22:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:22:20 INFO - "branch": "fx-team", 02:22:20 INFO - "repo_path": "integration/fx-team", 02:22:20 INFO - "revision": "d0c2f09a6285ad7a9f25fcb704de38c9c5168369", 02:22:20 INFO - "stage_platform": "linux64", 02:22:20 INFO - "builduid": "53cbf33aba3b4b43a8b31ea0e7abbaf5", 02:22:20 INFO - "slavebuilddir": "test" 02:22:20 INFO - } 02:22:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:22:20 INFO - Running post-action listener: _resource_record_post_action 02:22:20 INFO - ##### 02:22:20 INFO - ##### Running download-and-extract step. 02:22:20 INFO - ##### 02:22:20 INFO - Running pre-action listener: _resource_record_pre_action 02:22:20 INFO - Running main action method: download_and_extract 02:22:20 INFO - mkdir: /builds/slave/test/build/tests 02:22:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:20 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:22:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:22:32 INFO - Downloaded 1361 bytes. 02:22:32 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:22:32 INFO - Using the following test package requirements: 02:22:32 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:32 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:22:32 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:22:32 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'jsshell-linux-x86_64.zip'], 02:22:32 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:22:32 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:22:32 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:22:32 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:22:32 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:22:32 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:22:32 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:22:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:32 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:22:38 INFO - Downloaded 22202881 bytes. 02:22:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:22:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:22:39 INFO - Return code: 0 02:22:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:22:39 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')]} 02:22:39 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:22:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:22:42 INFO - Downloaded 22202881 bytes. 02:22:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:22:43 INFO - Return code: 0 02:22:43 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')]} 02:22:43 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:22:45 INFO - Downloaded 10841076 bytes. 02:22:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:22:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:22:45 INFO - Return code: 0 02:22: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')]} 02:22:45 INFO - https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:22:46 INFO - Downloaded 54445783 bytes. 02:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:46 INFO - mkdir: /builds/slave/test/properties 02:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:46 INFO - Contents: 02:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:22:47 INFO - Running post-action listener: _resource_record_post_action 02:22:47 INFO - Running post-action listener: set_extra_try_arguments 02:22:47 INFO - ##### 02:22:47 INFO - ##### Running populate-webroot step. 02:22:47 INFO - ##### 02:22:47 INFO - Running pre-action listener: _resource_record_pre_action 02:22:47 INFO - Running main action method: populate_webroot 02:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:47 INFO - '--tppagecycles', 02:22:47 INFO - '7'], 02:22:47 INFO - 'tests': ['tsvgm']}}, 02:22:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['damp', 'tps']}, 02:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'tests': ['damp', 'tps']}, 02:22:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['dromaeo_dom']}, 02:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['a11yr', 02:22:47 INFO - 'ts_paint', 02:22:47 INFO - 'tpaint', 02:22:47 INFO - 'sessionrestore', 02:22:47 INFO - 'sessionrestore_no_auto_restore', 02:22:47 INFO - 'tabpaint']}, 02:22:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['tsvgx', 02:22:47 INFO - 'tsvgr_opacity', 02:22:47 INFO - 'tart', 02:22:47 INFO - 'tscrollx', 02:22:47 INFO - 'cart']}, 02:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:47 INFO - 'tsvgr_opacity', 02:22:47 INFO - 'tart', 02:22:47 INFO - 'tscrollx', 02:22:47 INFO - 'cart']}, 02:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'talos_options': ['--disable-e10s'], 02:22:47 INFO - 'tests': ['tp5o']}, 02:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'tests': ['tp5o']}, 02:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'talos_options': ['--disable-e10s', 02:22:47 INFO - '--xperf_path', 02:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:47 INFO - 'tests': ['tp5n']}, 02:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:47 INFO - 'talos_options': ['--xperf_path', 02:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:47 INFO - 'tests': ['tp5n']}}, 02:22:47 INFO - 'talos.zip': {'path': '', 02:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:47 INFO - Running post-action listener: _resource_record_post_action 02:22:47 INFO - ##### 02:22:47 INFO - ##### Running create-virtualenv step. 02:22:47 INFO - ##### 02:22:47 INFO - Running pre-action listener: _resource_record_pre_action 02:22:47 INFO - Running main action method: create_virtualenv 02:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:47 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 02:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:47 INFO - Using real prefix '/usr' 02:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:50 INFO - Installing pip.................done. 02:22:50 INFO - Return code: 0 02:22:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:22:50 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 02:22:50 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 02:22:50 INFO - Using env: {'DISPLAY': ':0', 02:22:50 INFO - 'HOME': '/home/cltbld', 02:22:50 INFO - 'LANG': 'en_US.UTF-8', 02:22:50 INFO - 'LANGUAGE': 'en_US:en', 02:22:50 INFO - 'LOGNAME': 'cltbld', 02:22:50 INFO - 'MAIL': '/var/mail/cltbld', 02:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:50 INFO - 'MOZ_NO_REMOTE': '1', 02:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:50 INFO - 'NO_EM_RESTART': '1', 02:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:50 INFO - 'PWD': '/builds/slave/test', 02:22:50 INFO - 'SHELL': '/bin/bash', 02:22:50 INFO - 'SHLVL': '1', 02:22:50 INFO - 'TERM': 'linux', 02:22:50 INFO - 'TMOUT': '86400', 02:22:50 INFO - 'USER': 'cltbld', 02:22:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:50 INFO - '_': '/tools/buildbot/bin/python'} 02:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:50 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 02:22:50 INFO - Cleaning up... 02:22:50 INFO - Return code: 0 02:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:50 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:22:50 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 02:22:50 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 02:22:50 INFO - Using env: {'DISPLAY': ':0', 02:22:50 INFO - 'HOME': '/home/cltbld', 02:22:50 INFO - 'LANG': 'en_US.UTF-8', 02:22:50 INFO - 'LANGUAGE': 'en_US:en', 02:22:50 INFO - 'LOGNAME': 'cltbld', 02:22:50 INFO - 'MAIL': '/var/mail/cltbld', 02:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:50 INFO - 'MOZ_NO_REMOTE': '1', 02:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:50 INFO - 'NO_EM_RESTART': '1', 02:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:50 INFO - 'PWD': '/builds/slave/test', 02:22:50 INFO - 'SHELL': '/bin/bash', 02:22:50 INFO - 'SHLVL': '1', 02:22:50 INFO - 'TERM': 'linux', 02:22:50 INFO - 'TMOUT': '86400', 02:22:50 INFO - 'USER': 'cltbld', 02:22:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:50 INFO - '_': '/tools/buildbot/bin/python'} 02:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:50 INFO - Downloading/unpacking psutil>=0.7.1 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:52 INFO - Installing collected packages: psutil 02:22:52 INFO - Running setup.py install for psutil 02:22:52 INFO - building 'psutil._psutil_linux' extension 02:22:52 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 02:22:52 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 02:22:52 INFO - building 'psutil._psutil_posix' extension 02:22:52 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 02:22:52 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 02:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:22:52 INFO - Successfully installed psutil 02:22:52 INFO - Cleaning up... 02:22:52 INFO - Return code: 0 02:22:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:22:52 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')]} 02:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:52 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')]} 02:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:52 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:22:52 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 02:22:52 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 02:22:52 INFO - Using env: {'DISPLAY': ':0', 02:22:52 INFO - 'HOME': '/home/cltbld', 02:22:52 INFO - 'LANG': 'en_US.UTF-8', 02:22:52 INFO - 'LANGUAGE': 'en_US:en', 02:22:52 INFO - 'LOGNAME': 'cltbld', 02:22:52 INFO - 'MAIL': '/var/mail/cltbld', 02:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:52 INFO - 'MOZ_NO_REMOTE': '1', 02:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:52 INFO - 'NO_EM_RESTART': '1', 02:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:52 INFO - 'PWD': '/builds/slave/test', 02:22:52 INFO - 'SHELL': '/bin/bash', 02:22:52 INFO - 'SHLVL': '1', 02:22:52 INFO - 'TERM': 'linux', 02:22:52 INFO - 'TMOUT': '86400', 02:22:52 INFO - 'USER': 'cltbld', 02:22:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:52 INFO - '_': '/tools/buildbot/bin/python'} 02:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:22:55 INFO - Installing collected packages: mozsystemmonitor 02:22:55 INFO - Running setup.py install for mozsystemmonitor 02:22:55 INFO - Successfully installed mozsystemmonitor 02:22:55 INFO - Cleaning up... 02:22:55 INFO - Return code: 0 02:22:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:22:55 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')]} 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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')]} 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:22:55 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 02:22:55 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 02:22:55 INFO - Using env: {'DISPLAY': ':0', 02:22:55 INFO - 'HOME': '/home/cltbld', 02:22:55 INFO - 'LANG': 'en_US.UTF-8', 02:22:55 INFO - 'LANGUAGE': 'en_US:en', 02:22:55 INFO - 'LOGNAME': 'cltbld', 02:22:55 INFO - 'MAIL': '/var/mail/cltbld', 02:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:55 INFO - 'MOZ_NO_REMOTE': '1', 02:22:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:55 INFO - 'NO_EM_RESTART': '1', 02:22:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:55 INFO - 'PWD': '/builds/slave/test', 02:22:55 INFO - 'SHELL': '/bin/bash', 02:22:55 INFO - 'SHLVL': '1', 02:22:55 INFO - 'TERM': 'linux', 02:22:55 INFO - 'TMOUT': '86400', 02:22:55 INFO - 'USER': 'cltbld', 02:22:55 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:55 INFO - '_': '/tools/buildbot/bin/python'} 02:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:57 INFO - Downloading blobuploader-1.2.4.tar.gz 02:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:22:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22: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 02:22:57 INFO - Downloading docopt-0.6.1.tar.gz 02:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:22:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:22:58 INFO - Running setup.py install for blobuploader 02:22:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:22:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:22:58 INFO - Running setup.py install for requests 02:22:58 INFO - Running setup.py install for docopt 02:22:58 INFO - Successfully installed blobuploader requests docopt 02:22:58 INFO - Cleaning up... 02:22:58 INFO - Return code: 0 02:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:58 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:22:58 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 02:22:58 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 02:22:58 INFO - Using env: {'DISPLAY': ':0', 02:22:58 INFO - 'HOME': '/home/cltbld', 02:22:58 INFO - 'LANG': 'en_US.UTF-8', 02:22:58 INFO - 'LANGUAGE': 'en_US:en', 02:22:58 INFO - 'LOGNAME': 'cltbld', 02:22:58 INFO - 'MAIL': '/var/mail/cltbld', 02:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:58 INFO - 'MOZ_NO_REMOTE': '1', 02:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:22:58 INFO - 'NO_EM_RESTART': '1', 02:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:58 INFO - 'PWD': '/builds/slave/test', 02:22:58 INFO - 'SHELL': '/bin/bash', 02:22:58 INFO - 'SHLVL': '1', 02:22:58 INFO - 'TERM': 'linux', 02:22:58 INFO - 'TMOUT': '86400', 02:22:58 INFO - 'USER': 'cltbld', 02:22:58 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:58 INFO - '_': '/tools/buildbot/bin/python'} 02:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:22:58 INFO - Running setup.py (path:/tmp/pip-QF57wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:22:59 INFO - Running setup.py (path:/tmp/pip-XCQBw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:22:59 INFO - Running setup.py (path:/tmp/pip-rxf6q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:22:59 INFO - Running setup.py (path:/tmp/pip-mcgffx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:22:59 INFO - Running setup.py (path:/tmp/pip-h_cdpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:22:59 INFO - Running setup.py (path:/tmp/pip-0ozTSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:22:59 INFO - Running setup.py (path:/tmp/pip-6gBnbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:22:59 INFO - Running setup.py (path:/tmp/pip-ZMD2dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:22:59 INFO - Running setup.py (path:/tmp/pip-aMbi4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:22:59 INFO - Running setup.py (path:/tmp/pip-La5zr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:22:59 INFO - Running setup.py (path:/tmp/pip-Gvvj1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:22:59 INFO - Running setup.py (path:/tmp/pip-qhA7yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:22:59 INFO - Running setup.py (path:/tmp/pip-ro6nHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:22:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:22:59 INFO - Running setup.py (path:/tmp/pip-yotnCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:00 INFO - Running setup.py (path:/tmp/pip-MJP9ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:00 INFO - Running setup.py (path:/tmp/pip-Pk4tkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:00 INFO - Running setup.py (path:/tmp/pip-P6Rbfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:00 INFO - Running setup.py install for manifestparser 02:23:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Running setup.py install for mozcrash 02:23:00 INFO - Running setup.py install for mozdebug 02:23:00 INFO - Running setup.py install for mozdevice 02:23:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Running setup.py install for mozfile 02:23:00 INFO - Running setup.py install for mozhttpd 02:23:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Running setup.py install for mozinfo 02:23:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:23:00 INFO - Running setup.py install for mozInstall 02:23:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozleak 02:23:01 INFO - Running setup.py install for mozlog 02:23:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for moznetwork 02:23:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozprocess 02:23:01 INFO - Running setup.py install for mozprofile 02:23:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozrunner 02:23:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:23:01 INFO - Running setup.py install for mozscreenshot 02:23:01 INFO - Running setup.py install for moztest 02:23:01 INFO - Running setup.py install for mozversion 02:23:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:02 INFO - Cleaning up... 02:23:02 INFO - Return code: 0 02:23:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:02 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')]} 02:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 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')]} 02:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:02 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:23:02 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 02:23:02 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 02:23:02 INFO - Using env: {'DISPLAY': ':0', 02:23:02 INFO - 'HOME': '/home/cltbld', 02:23:02 INFO - 'LANG': 'en_US.UTF-8', 02:23:02 INFO - 'LANGUAGE': 'en_US:en', 02:23:02 INFO - 'LOGNAME': 'cltbld', 02:23:02 INFO - 'MAIL': '/var/mail/cltbld', 02:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:02 INFO - 'MOZ_NO_REMOTE': '1', 02:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:02 INFO - 'NO_EM_RESTART': '1', 02:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:02 INFO - 'PWD': '/builds/slave/test', 02:23:02 INFO - 'SHELL': '/bin/bash', 02:23:02 INFO - 'SHLVL': '1', 02:23:02 INFO - 'TERM': 'linux', 02:23:02 INFO - 'TMOUT': '86400', 02:23:02 INFO - 'USER': 'cltbld', 02:23:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:02 INFO - '_': '/tools/buildbot/bin/python'} 02:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:02 INFO - Running setup.py (path:/tmp/pip-liX7A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:02 INFO - Running setup.py (path:/tmp/pip-UdBzaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:02 INFO - Running setup.py (path:/tmp/pip-mOyMb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:02 INFO - Running setup.py (path:/tmp/pip-Xj4Eey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:02 INFO - Running setup.py (path:/tmp/pip-V40Ve5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:02 INFO - Running setup.py (path:/tmp/pip-3LFoUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:02 INFO - Running setup.py (path:/tmp/pip-HxIi1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:02 INFO - Running setup.py (path:/tmp/pip-b5yWY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:02 INFO - Running setup.py (path:/tmp/pip-jCodHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:02 INFO - Running setup.py (path:/tmp/pip-lMq2wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:02 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)) 02:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:02 INFO - Running setup.py (path:/tmp/pip-mJk_Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:03 INFO - Running setup.py (path:/tmp/pip-i93Y_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:03 INFO - Running setup.py (path:/tmp/pip-3CCPol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:03 INFO - Running setup.py (path:/tmp/pip-8BaEPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:03 INFO - Running setup.py (path:/tmp/pip-ciAY1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:03 INFO - Running setup.py (path:/tmp/pip-oJuZwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:03 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)) 02:23:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:03 INFO - Running setup.py (path:/tmp/pip-DjPqvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:03 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)) 02:23:03 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)) 02:23:03 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)) 02:23:03 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)) 02:23:03 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)) 02:23:03 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)) 02:23:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:05 INFO - Downloading blessings-1.6.tar.gz 02:23:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:05 INFO - Installing collected packages: blessings 02:23:05 INFO - Running setup.py install for blessings 02:23:05 INFO - Successfully installed blessings 02:23:05 INFO - Cleaning up... 02:23:05 INFO - Return code: 0 02:23:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:05 INFO - Reading from file tmpfile_stdout 02:23:05 INFO - Current package versions: 02:23:05 INFO - argparse == 1.2.1 02:23:05 INFO - blessings == 1.6 02:23:05 INFO - blobuploader == 1.2.4 02:23:05 INFO - docopt == 0.6.1 02:23:05 INFO - manifestparser == 1.1 02:23:05 INFO - mozInstall == 1.12 02:23:05 INFO - mozcrash == 0.17 02:23:05 INFO - mozdebug == 0.1 02:23:05 INFO - mozdevice == 0.48 02:23:05 INFO - mozfile == 1.2 02:23:05 INFO - mozhttpd == 0.7 02:23:05 INFO - mozinfo == 0.9 02:23:05 INFO - mozleak == 0.1 02:23:05 INFO - mozlog == 3.1 02:23:05 INFO - moznetwork == 0.27 02:23:05 INFO - mozprocess == 0.22 02:23:05 INFO - mozprofile == 0.28 02:23:05 INFO - mozrunner == 6.11 02:23:05 INFO - mozscreenshot == 0.1 02:23:05 INFO - mozsystemmonitor == 0.0 02:23:05 INFO - moztest == 0.7 02:23:05 INFO - mozversion == 1.4 02:23:05 INFO - psutil == 3.1.1 02:23:05 INFO - requests == 1.2.3 02:23:05 INFO - wsgiref == 0.1.2 02:23:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:05 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:23:05 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 02:23:05 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 02:23:05 INFO - Using env: {'DISPLAY': ':0', 02:23:05 INFO - 'HOME': '/home/cltbld', 02:23:05 INFO - 'LANG': 'en_US.UTF-8', 02:23:05 INFO - 'LANGUAGE': 'en_US:en', 02:23:05 INFO - 'LOGNAME': 'cltbld', 02:23:05 INFO - 'MAIL': '/var/mail/cltbld', 02:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:05 INFO - 'MOZ_NO_REMOTE': '1', 02:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:05 INFO - 'NO_EM_RESTART': '1', 02:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:05 INFO - 'PWD': '/builds/slave/test', 02:23:05 INFO - 'SHELL': '/bin/bash', 02:23:05 INFO - 'SHLVL': '1', 02:23:05 INFO - 'TERM': 'linux', 02:23:05 INFO - 'TMOUT': '86400', 02:23:05 INFO - 'USER': 'cltbld', 02:23:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:05 INFO - '_': '/tools/buildbot/bin/python'} 02:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 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)) 02:23:06 INFO - Cleaning up... 02:23:06 INFO - Return code: 0 02:23:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:06 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')]} 02:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 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')]} 02:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:06 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 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:23:06 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 02:23:06 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 02:23:06 INFO - Using env: {'DISPLAY': ':0', 02:23:06 INFO - 'HOME': '/home/cltbld', 02:23:06 INFO - 'LANG': 'en_US.UTF-8', 02:23:06 INFO - 'LANGUAGE': 'en_US:en', 02:23:06 INFO - 'LOGNAME': 'cltbld', 02:23:06 INFO - 'MAIL': '/var/mail/cltbld', 02:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:06 INFO - 'MOZ_NO_REMOTE': '1', 02:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:06 INFO - 'NO_EM_RESTART': '1', 02:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:06 INFO - 'PWD': '/builds/slave/test', 02:23:06 INFO - 'SHELL': '/bin/bash', 02:23:06 INFO - 'SHLVL': '1', 02:23:06 INFO - 'TERM': 'linux', 02:23:06 INFO - 'TMOUT': '86400', 02:23:06 INFO - 'USER': 'cltbld', 02:23:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:06 INFO - '_': '/tools/buildbot/bin/python'} 02:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:06 INFO - Downloading/unpacking jsonschema 02:23:06 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 02:23:06 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 02:23:06 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 02:23:06 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 02:23:06 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 02:23:06 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 02:23:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:08 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:08 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 02:23:08 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 02:23:08 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 02:23:08 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 02:23:08 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 02:23:08 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 02:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:08 INFO - warning: no files found matching '*.txt' 02:23:08 INFO - no previously-included directories found matching 'build' 02:23:08 INFO - no previously-included directories found matching 'dist' 02:23:08 INFO - no previously-included directories found matching '.git*' 02:23:08 INFO - Installing collected packages: jsonschema, functools32 02:23:08 INFO - Running setup.py install for functools32 02:23:08 INFO - warning: no files found matching '*.txt' 02:23:08 INFO - no previously-included directories found matching 'build' 02:23:08 INFO - no previously-included directories found matching 'dist' 02:23:08 INFO - no previously-included directories found matching '.git*' 02:23:08 INFO - Successfully installed jsonschema functools32 02:23:08 INFO - Cleaning up... 02:23:08 INFO - Return code: 0 02:23:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0137e18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29ba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', '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 02:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:23:08 INFO - Using env: {'DISPLAY': ':0', 02:23:08 INFO - 'HOME': '/home/cltbld', 02:23:08 INFO - 'LANG': 'en_US.UTF-8', 02:23:08 INFO - 'LANGUAGE': 'en_US:en', 02:23:08 INFO - 'LOGNAME': 'cltbld', 02:23:08 INFO - 'MAIL': '/var/mail/cltbld', 02:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:08 INFO - 'MOZ_NO_REMOTE': '1', 02:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:08 INFO - 'NO_EM_RESTART': '1', 02:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:08 INFO - 'PWD': '/builds/slave/test', 02:23:08 INFO - 'SHELL': '/bin/bash', 02:23:08 INFO - 'SHLVL': '1', 02:23:08 INFO - 'TERM': 'linux', 02:23:08 INFO - 'TMOUT': '86400', 02:23:08 INFO - 'USER': 'cltbld', 02:23:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:08 INFO - '_': '/tools/buildbot/bin/python'} 02:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:09 INFO - Downloading/unpacking flake8 02:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:23:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:23:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:11 INFO - no previously-included directories found matching 'docs/_build' 02:23:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:23:11 INFO - Running setup.py install for pep8 02:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:23:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:23:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:23:11 INFO - no previously-included directories found matching 'docs/_build' 02:23:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:23:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:23:11 INFO - Cleaning up... 02:23:11 INFO - Return code: 0 02:23:11 INFO - Running post-action listener: _resource_record_post_action 02:23:11 INFO - Running post-action listener: _start_resource_monitoring 02:23:11 INFO - Starting resource monitoring. 02:23:11 INFO - ##### 02:23:11 INFO - ##### Running install step. 02:23:11 INFO - ##### 02:23:11 INFO - Running pre-action listener: _resource_record_pre_action 02:23:11 INFO - Running main action method: install 02:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:12 INFO - Reading from file tmpfile_stdout 02:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:12 INFO - Reading from file tmpfile_stdout 02:23:12 INFO - Output received: 02:23:12 INFO - Usage: mozinstall [options] installer 02:23:12 INFO - Options: 02:23:12 INFO - -h, --help show this help message and exit 02:23:12 INFO - -d DEST, --destination=DEST 02:23:12 INFO - Directory to install application into. [default: 02:23:12 INFO - "/builds/slave/test"] 02:23:12 INFO - --app=APP Application being installed. [default: firefox] 02:23:12 INFO - mkdir: /builds/slave/test/build/application 02:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:23:27 INFO - Reading from file tmpfile_stdout 02:23:27 INFO - Output received: 02:23:27 INFO - /builds/slave/test/build/application/firefox/firefox 02:23:27 INFO - Running post-action listener: _resource_record_post_action 02:23:27 INFO - ##### 02:23:27 INFO - ##### Running run-tests step. 02:23:27 INFO - ##### 02:23:27 INFO - Running pre-action listener: _resource_record_pre_action 02:23:27 INFO - Running main action method: run_tests 02:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:27 INFO - Python 2.7.3 02:23:27 INFO - Return code: 0 02:23:27 INFO - grabbing minidump binary from tooltool 02:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:27 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 0x2a49410>, '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 0x2a4a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a4a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:27 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 02:23:27 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 02:23:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:27 INFO - Return code: 0 02:23:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:23:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:23:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:23:28 INFO - Return code: 0 02:23:28 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/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:23:28 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/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 02:23:28 INFO - Using env: {'DISPLAY': ':0', 02:23:28 INFO - 'HOME': '/home/cltbld', 02:23:28 INFO - 'LANG': 'en_US.UTF-8', 02:23:28 INFO - 'LANGUAGE': 'en_US:en', 02:23:28 INFO - 'LOGNAME': 'cltbld', 02:23:28 INFO - 'MAIL': '/var/mail/cltbld', 02:23:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:28 INFO - 'MOZ_NO_REMOTE': '1', 02:23:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:28 INFO - 'NO_EM_RESTART': '1', 02:23:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:28 INFO - 'PWD': '/builds/slave/test', 02:23:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:28 INFO - 'SHELL': '/bin/bash', 02:23:28 INFO - 'SHLVL': '1', 02:23:28 INFO - 'TERM': 'linux', 02:23:28 INFO - 'TMOUT': '86400', 02:23:28 INFO - 'USER': 'cltbld', 02:23:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702', 02:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:28 INFO - '_': '/tools/buildbot/bin/python'} 02:23:28 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/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 02:23:29 INFO - mozversion application_buildid: 20160415014444 02:23:29 INFO - mozversion application_changeset: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 02:23:29 INFO - mozversion application_display_name: Nightly 02:23:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:29 INFO - mozversion application_name: Firefox 02:23:29 INFO - mozversion application_remotingname: firefox 02:23:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:23:29 INFO - mozversion application_vendor: Mozilla 02:23:29 INFO - mozversion application_version: 48.0a1 02:23:29 INFO - mozversion platform_buildid: 20160415014444 02:23:29 INFO - mozversion platform_changeset: d0c2f09a6285ad7a9f25fcb704de38c9c5168369 02:23:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:23:29 INFO - mozversion platform_version: 48.0a1 02:23:29 INFO - using testdate: 1460712209 02:23:29 INFO - actual date: 1460712209 02:23:29 INFO - starting webserver on 'localhost:47359' 02:23:29 INFO - SUITE-START | Running 2 tests 02:23:29 INFO - TEST-START | dromaeo_css 02:23:29 INFO - operating with platform_type : linux_ 02:23:29 INFO - Initialising browser for dromaeo_css test... 02:23:29 INFO - TEST-INFO | started process 19791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVvXEJD/profile http://localhost:47359/getInfo.html) 02:23:33 INFO - PROCESS | 19791 | 02:23:33 INFO - PROCESS | 19791 | (process:19858): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:23:33 INFO - PROCESS | 19791 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 02:23:34 INFO - PROCESS | 19791 | __metrics Screen width/height:1600/1200 02:23:34 INFO - PROCESS | 19791 | colorDepth:24 02:23:34 INFO - PROCESS | 19791 | Browser inner width/height: 1024/697 02:23:34 INFO - PROCESS | 19791 | __metrics 02:23:34 ERROR - PROCESS | 19791 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:23:36 INFO - TEST-INFO | 19791: exit 0 02:23:36 INFO - Browser initialized. 02:23:36 INFO - Running cycle 1/1 for dromaeo_css test... 02:23:36 INFO - TEST-INFO | started process 19909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVvXEJD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:38 INFO - PROCESS | 19909 | 02:23:38 INFO - PROCESS | 19909 | (process:19968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:23:48 INFO - PROCESS | 19909 | RSS: Main: 163950592 02:23:48 INFO - PROCESS | 19909 | 02:24:37 INFO - PROCESS | 19909 | 1460712277927 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] 02:26:50 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47359/tests/dromaeo/cssquery-ext.html) 02:26:51 INFO - PROCESS | 19909 | RSS: Main: 166502400 02:26:51 INFO - PROCESS | 19909 | 02:29:53 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-ext.html (next: http://localhost:47359/tests/dromaeo/cssquery-jquery.html) 02:29:54 INFO - PROCESS | 19909 | RSS: Main: 164941824 02:29:54 INFO - PROCESS | 19909 | 02:32:55 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47359/tests/dromaeo/cssquery-mootools.html) 02:32:56 INFO - PROCESS | 19909 | RSS: Main: 166309888 02:32:56 INFO - PROCESS | 19909 | 02:35:58 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47359/tests/dromaeo/cssquery-prototype.html) 02:35:58 INFO - PROCESS | 19909 | RSS: Main: 163471360 02:35:58 INFO - PROCESS | 19909 | 02:39:01 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47359/tests/dromaeo/cssquery-yui.html) 02:39:02 INFO - PROCESS | 19909 | RSS: Main: 164495360 02:39:02 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | Cycle 1(1): loaded http://localhost:47359/tests/dromaeo/cssquery-yui.html (next: http://localhost:47359/tests/dromaeo/cssquery-dojo.html) 02:42:04 INFO - PROCESS | 19909 | RSS: Main: 167124992 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | __start_tp_report 02:42:04 INFO - PROCESS | 19909 | _x_x_mozilla_page_load 02:42:04 INFO - PROCESS | 19909 | _x_x_mozilla_page_load_details 02:42:04 INFO - PROCESS | 19909 | |i|pagename|runs| 02:42:04 INFO - PROCESS | 19909 | |0;dojo.html;2643.695974962879;2700.4734076855007;2738.6302849115364;2745.807793454459;2745.8901643934246;4800.375951126353;4806.591439727623;4817.205161148415;4826.444958829736;4894.167991441454;4699.647526435514;4813.6389770767155;4829.396325459317;4881.804727810883;4882.658213925027;4402.603765661098;4429.402030725859;4475.418195634563;4521.660875434355;4568;4450.599446049855;4471.39636149119;4498.212812757771;4512.187806194884;4561.201789686808;4334.653227741789;4363.367311739812;4452.109578084363;4452.48796388413;4483.170613436492;4407.735535867858;4409.206342858284;4413.183561041185;4422.778861056967;4477.932831007537;4383.430154079981;4411.09572537629;4414.4923333816705;4454.754988475633;4467.441569803775;4603.194440972817;4668.649851261169;4714.080754252922;4738.881527961794;4756.9286460703115;5097.439281679012;5129.461406552296;5129.461406552333;5163.302954101186;5189.325387699612;5033.270175824521;5184.27420161174;5184.870378240536;5189.117849965515;5196.350456192976;4764.571188593043;4774.045190961821;4813.253945638432;4843.055604157226;4861.611071114302;5236.711980841091;5251.8161864335325;5252.737363131904;5263.6841789492755;5277.551408130275;4910.263460480885;5041.596672266283;5069.543741063322;5079.136546786981;5085.821996230188;5029.094762942632;5114.488551144856;5177.637565370388;5202.505761952609;5240.318758561362;5079.288899554065;5095.821646242363;5100.617453690914;5110;5155.639105262596;5001.624878134082;5082.390113186368;5091.0836049511445;5096.770645320969;5103;4247.68142389322;4317.309230523164;4317.611414972667;4340.327249276367;4373.103513779667;3720.3489389356755;3764.5294338207723;3780.9980355205894;3781.3760729479327;3784;4380.561943805657;4450.109978004347;4451.621612162938;4508.211063064016;4538.160440318552;5166.302549155891;5208.088584497697;5230.843074707765;5231.921521177185;5276.577873770089;4480.439945006874;4534.410526631516;4541.409616749801;4552.430946131733;4583.083383323348;4500.032493014018;4584.633229341644;4622.791974361162;4672.065586882569;4711.316859055418;4859.975700121477;4914.361133052752;4919.606431485401;4921.335619691439;4957.851264462072;5185.351831021122;5233.267342572119;5237.869053273698;5243.947560524346;5277.920831187458;4784.6889952153;4885.755712214304;4909.582685471775;4926.8768280793265;4973.154563724248;5069.467705890976;5077.263796749525;5091.236314552847;5094.981003799181;5174.172132458789;5149.407818100966;5199.090159222045;5199.792008319625;5200.349956255468;5213.374395072616;4869.805207791649;4871.975640121776;4967.726775027409;5008.248762685626;5039.949600503948;4949.653524253267;4953.23224900141;4961.603071754179;4975.477574854588;5005.24921261799;4903.828366007173;4924.359833221658;4929.137400954747;4945.357103576512;4970.676906001098;4946.183879659816;5003.124453220599;5004.724740139181;5039.874003149951;5068.847934561969;4923.8276660316715;4941.308216849716;4975.676581022367;4987.825426110068;5023.271625614192 02:42:04 INFO - PROCESS | 19909 | |1;ext.html;561.1441211535055;568.8293511946416;595.2797115490255;602.7378090530617;602.7588964414231;26443.603345949825;33728.66271337286;34619.65380346196;34697;34711.65288347116;37758;38478.23043539128;38637.613623863755;38722.03194920121;38736.61263387365;7641.4335061312295;7846.6469008894455;7860.37117030639;7875.173106823787;7900.565468899208;7692.769216923473;7762.573058481781;7778.64996075178;7842.921570784276;7966.243206895365;7925.405594580401;7995.640196191156;8001.479903806234;8012;8027.397945154137;7933.682652693886;7937.206279372074;7941.722039728611;7993.760187194393;8002.799930001738;7769.53382797034;7918.049834019955;7925.088614809255;7928.286454219148;7946.2848343648775;37924.43113353302;38041.61958380409;38192;38335.616643833484;38409.80795096035;2924.8683809228637;3033.8028028178096;3050.9847450762827;3105.534169874537;3414.9658503415144;28903.42193156146;29084.12747617575;29087.56368654472;29377.412451751057;29707;3351.9664803352143;3384.3062172254627;3424.7945123292684;3474.687278144954;3525.982370088159;234781;237129;237539;237618;238616.99999999825;29418.264543386158;51750;52841;53082;53174.734126329124;27837;27882.860585697348;27961.44077118446;28024.43951120966;28167.859160704476;13195.406206720721;13278.800817987738;13372.197668139943;13437.865621343857;13440.395182216627;11286;11339.092872570174;11371;11377.886221137682;11398.088152947745;8111.269985701315;8122.9187708123345;8185.877211841827;8195.139510351328;8239.917600824036;3189.6012998375204;3190.734578449327;3251.8374081296315;3311.536384906115;3323.7673362864366;986.3933680786408;1013.1388319928002;1048.1352883870836;1072.51736718477;1080.713610893114;28159.577606335923;28193.295167620974;28555.286117846805;28583.85708071488;28870.278243044093;992.7418871093423;1042.4370839746452;1069.614938622111;1105.745678493951;1128.2440764687678;14129.929350353183;14941.925290373478;15120.092794432368;15205.61985950338;15380.154091525073;293845;298522;306002;306732;307865;49349.25976110361;50222.24666630004;50278.49721502738;50357.49642503601;50363.74818125886;1266.5877546535546;1288.5425673885823;1321.0554453565555;1331.5672406467936;1334.7130366971148;26521.734782651925;27636.72363276422;28047.29881752891;28170.85914570414;28181.859090704416;42382;43082.13835723331;43117.568824311355;43213.567864320954;43304.56695433131;251528;251560;254640;254707;254929;37286.813565931996;37508.81245593754;38313.808430957666;38662.22675546529;38691.80654096712;41717;41762.791186043876;42627.3605895918;42730.359044614976;43063.56936430596;35945.281094378486;36081.63918360888;36383.45424818577;36405.63594364023;36561;35200.47199292064;35518.28963420665;36314.8184259077;36531.269374611824;37718.62281377261;32851.67148328582;33089.50365744468;33768;36950.89147325585;38081.619183808914;28944.276393090342;32569.18577035593;33625.15937101592;34286.828565858006;34440.82779586086;23102.537949240585;23168.18911338095;23182.1886233981;23342.183023594094;23364 02:42:04 INFO - PROCESS | 19909 | |2;jquery.html;361.400075874049;362.5920839056062;372.79496277047633;384.9576546579874;389.5695256741301;15645;15840.683186336266;16762.497125086236;16838.15809209538;16859.15704214789;15461.458848940289;15643.217839108056;16113.91943040286;16325.91837040816;16328.591785205375;5145.691258524501;5304.416514183436;5328.387235467912;5332.280142180794;5355.973220133894;3649;5182.922256166161;5722.570807189457;6082.391760823926;6092.878142437148;6004.099385092228;6017.368176341487;6018.8194354169445;6019.458248757611;6030.668313242792;5015.3730783652045;5314.681119132864;5344.893102137936;5363.731813409353;5371.946280537184;5089.669171503878;5193.480651934814;5321.308229930123;5500.477454641843;5510.8071217507595;12103.636890893287;12422.689432764162;12468.376581170996;12481.126321157522;12506.374681265901;1684.309433132422;1751.5971326594827;1885.161103309028;1919.7888232294436;1993.2326054468988;8979.68571100015;9020.909790902073;9238.260939124853;9370;9453.43279403238;1775.9911200443914;1852.9536761581069;1863.4130248971667;1867.2530987605066;1887.9339223127124;69292.6535367325;71817;73271.26728732698;74057.25942740611;74669;9766.267529935283;9777.560009799576;10061.446620435947;10073.445960472245;10107.7473063174;13809.654758631115;13840.377183026789;13864.098833575785;13877.028607997545;13898.791518127236;6861.519693621499;6902.516823822385;6975.441964642816;7041.436685065182;7074.610896400747;6465.418112369909;6535.790878687458;6553.705083271264;6651.102101216371;6667.86664266712;4114.403411505315;4172.311568591209;4192.329227323675;4219.1139860629;4235.882058970515;1626.991865040667;1750.9737353939702;1760.119940029985;1838.5955089880206;1898.032003678134;833.4999000599591;870.6473878079388;880.4057261348693;897.9102089791099;909.340727972228;15668.373265069498;15873.52379428619;16509.58726031859;16722;16892.324307027582;903.1645727701981;910.499225426013;914.1087439746194;956.8421210500189;978.2467500024941;9117.77205569866;9244.722658320261;9440.527973601293;9466.479343636029;9548.570314335871;288391;296477;376830;377303;384572;67228.32771672221;71308.64345678239;83622;83929;84908;964.840801267797;967.8935317115112;979.7991411760572;983.9360441571275;995.716220877061;15276;15277.388904443698;15534.22328883574;15713.764293535834;15865.920670396574;30975.84512077425;31156;31734;32839.34321313513;35443.582256709444;38190.045248869;39719.205615886945;39771.80114099411;39914.2017159661;40122.59877401189;7706.422018348534;7731.884021739791;7821.530708157301;7865.370770338473;7950.284474397101;6442.645654488861;9931.304808663324;10489.580416783243;11079.224454288445;11094.833577496183;9550.617975280911;9792.608295668379;9892.851607225753;9894.455804930798;10121.336196135158;10219.59121635156;10223.064934033664;10375.011241344273;10416.375017498975;10616.89383106159;9997.500124993867;10689.679309620724;10762.300450470695;10800.135989121009;10965.780684386427;6675.632840193836;7016.982537532132;7882.211778822072;7892.84214315722;7926.603669816602;9408.435493870116;9868.259880508847;9888.752781180528;10000.649977250761;10040.397576145455 02:42:04 INFO - PROCESS | 19909 | |3;mootools.html;1458.2052781234227;1486.5168820133456;1650.2326418215528;1785.5982403959104;1805.524365596227;6944.861102777942;7488.176300606929;7630.351420129289;7848.411369147316;7874.724384646539;7488.85022299555;7513.361364284029;7516.5865877376855;7529.962350188255;7574.280443357886;2138.433315171477;2167.8265738740943;2169.110664627503;2169.7287839020123;2171.913123475059;2156.590247852903;2158.1583182558816;2188.5951099046647;2190.9780902190932;2192.440927563469;2148.731408573928;2179.073893595216;2192.1888901106613;2194.2320187934256;2208.4147700859285;2105.842061845368;2123.150739704115;2126.797954194349;2130.648443006902;2134.861234019799;2090.937271881846;2115.3653903828945;2119.4171602809197;2121.352987338861;2139.2726472999097;7556.093268807724;7616.733414330527;7656.425768067362;7680.5391676499585;7683.231676832328;4446.3108218226225;4559.088182363507;4566.429196350457;4571.725696458223;4575.359449677047;2920.810147340437;2929.8828046878098;2960.9111726648234;3022.063160420255;3026.9848650756826;942.9057094290516;968.8498282766183;983.6016413352604;988.2390559269322;989.3124278626358;10151.746206344827;10181.541830617565;10182.490875456271;10188.898111018869;10208.234382421348;4072.714909956275;4122.175564886975;4265.53079161292;4285.142971405731;4287.528371879091;8746.256568191648;8776.297896168291;8802.735917922473;8837.823243535222;8846.557672116369;4500.752458614807;4534.13851368239;4541.909161816745;4552.180607490617;4576.359309696645;3809.961900381016;4060.959390406117;4104.322786740214;4182.728122672017;4286.906838756097;3685;3707;3772.6981841452616;3787;3818.1218319786603;1201.237214368882;1239.3307613888398;1249.8375211222483;1260.0990291941307;1275.4515558310015;804.2038382001776;895.8745775591423;908.0964440381862;913.7989642278689;915.7023967210683;5570;5606.747696353674;5623.550115990711;5695.686737229492;5756.194132821408;439.40680081889195;440.7113340761806;444.27583039645174;445.61899575862174;451.58454222115734;3649.197176621139;3665.8533658653355;3671.3391589514144;3716.4053751399647;3746.4193050077283;9387.812243755086;9916.702498925044;9958.253131015203;9983.400995940267;9984.750381240381;9568.425894446356;9766.121049105615;9845;9861.802763944681;9873.950630246947;7368.226336234726;7376.114866215981;7433.553986760703;7523.059617547807;7529.134149572869;5300.469953004823;5432.619716619799;5512.5314348280845;5535.169724541351;5577.637453565505;8892.199702026848;9121.042290559395;9148.542572871196;9183.357164998386;9187.448753074837;8848.557572121497;9216.447013179231;9263;9362.391444556082;9376.156145946898;6167.475764560063;6500.837479063061;6647.5014373921185;6732.293109223461;6765.42493888025;7245.420366370572;7284.125904891447;7304.598247096461;7348.448866335153;7388.889166662612;6449.516286278454;6548.901766473602;6670.39966403026;6708.798736037927;6738.797836064926;6456.580322279036;6498.675066246763;6662.267150613526;6749.257581666111;6760.391564759196;6572.7042283098335;6642.468602511691;6657.167854018247;6664.900026499703;6667.266600674019;4708.835190768306;4746.098241334135;4834.95165048345;4909.754512274443;4910.06708725341;4796.808127674994;4903.068417000758;4920.40955085392;4940.135476291563;4994.225894986283 02:42:04 INFO - PROCESS | 19909 | |4;prototype.html;318.59220198146375;320.64408506557714;322.13828010073064;327.27835123552586;328.23193726679597;5341.866453338664;5412.4587541245855;5457.544105152678;5458.6724796512135;5466.1527463243265;5349.5720342372615;5351.331083614548;5352.090144675405;5363.544098751601;5383.542398896098;3932.8230229639594;4047.655949244303;4149.5228048774325;4177.51958524769;4199.433076534675;4187.853425130121;4194.832206711728;4202.97898510507;4206.747595144286;4208.642265407429;4150.211459822624;4166;4166.916541729135;4175.582441755815;4181.560936101711;4065.349544072949;4166.375043743433;4170.812313445902;4172.749635021908;4178.352355384905;3651.1054791575966;3656.8354424050717;3678.6321367863266;3690.833912473918;3704.74066815323;5124.461931497176;5140.91545072957;5168.405633352138;5185.585153187736;5196.636235463519;4754.215554433515;4792;4802.183628783116;4839.854804355875;4870.805167793284;5638.238837756891;5645.181448689917;5647.632903861236;5667.716614169316;5684.118961560965;3985.8405663773415;3990.6009399060154;4023.5775243599587;4049.2104039712267;4065.6544193743566;5684.772609095631;5910.08393698973;5913.881722365529;5976.671283079429;6003.889280483081;4123.340265557496;4129.669626429878;4130.277201489727;4152.418661387408;4165.875023749292;4195.685323600742;4195.811188496525;4201.558836322203;4211.410402543646;4219.599138081878;4642.651801114863;4783.880402989884;4789.137955168103;4792.856214313576;4799.424069111729;5642.379338272786;5645.71771411436;5646.20953066571;5653.943460565341;5662.886742265214;1456.3955958277409;1471.6468047668482;1473.5358362115899;1484.3988184784964;1486.9405223790927;942.1050002497655;963.494165563071;991.7768502087117;997.6258902911409;1011.6004178349658;4941.2835138905375;4960.826371076995;4980.7509624518625;4987.5760560352055;4997.500249975046;5781.82654520365;5806.68063256525;5839.620424672383;5848.736806843617;5870.442307980735;4861.5914372297975;4993.950060499348;5007.749612519359;5027.899442011212;5035.672681275705;3145.8741650334186;3154.1326135312515;3156.779025468241;3166.799074643101;3172.3655268946304;5510.889782204334;5514.255575497336;5517.393086760453;5518.668879867221;5537.723113844372;5798;5986.311574168939;6002.6098303611;6004.759809607567;6016.338202797689;5471.671699698031;5478.424765399575;5480.479354461399;5494.230807686927;5496.945030549723;5700.714964251853;5799.739011744566;5825.79609713658;5829.708514574169;5954.315253745702;5777.971110144423;5779.971100144472;5810.767569297181;5830.154627578892;5851.590388672922;5491.395946445808;5500.752466138953;5551.861203469945;5559.749811258423;5605.299337582802;3828.406596977473;4009.4787677601726;4024.7987600620436;4048.716589838683;4077.612626800449;5820.563457740602;5859.296884373903;5871.647701137946;5882.705864706833;5907.556933230111;5555.888582504187;5671.801486948102;5674.631148975303;5684;5699.6035971185665;5556.138798486241;5663.235463212413;5675.914861277167;5701.201831743476;5717.399673034438;5348.983693098299;5560.387487628543;5576.470235327637;5584.274044374205;5593.776248949996;5616.241807355955;5772.278465191851;5791.9131213031;5792.160136780059;5795.652260864362;5589.972050139723;5620.4098569649595;5625.09998400254;5625.746841392229;5642.097264437671 02:42:04 INFO - PROCESS | 19909 | |5;yui.html;687.8005378440253;700.8983697363885;728.4572993120123;779.6842278877054;789.7551758954725;11388.886111138887;11725.7654846903;11886.405679716023;11933.985611223046;12391;12636.178648387848;12804.551840685577;12819.294938778363;12832.422540985655;12837.037222208324;641.7785863876978;815.343648363069;819.5656302159865;821.7329367955408;826.9751907442757;794.7774623105539;797.5812698333392;803.8191406933452;804.569555287921;809.0210844877705;836.9916300837006;838.1618381618382;838.4214891724721;840.9747707568782;843.9493630382196;833.1418638801983;834.9916500834975;836.3685417509741;838.4969018588829;852.1776485691306;617.305531277313;622.2781573374864;623.6414061914418;627.3976982097192;630.6247782569363;11416.42917854104;11455.026322762575;11462.541498340057;11504.194706370557;11511.136664750093;12316.076294277875;12485.188462749893;12486.937565312206;12532.624021279376;12814.935925320313;9873.456959867204;9959.90040099597;10044.698659040241;10100.545475453622;10106.848397274047;3268.1176082457605;3313.1717070732316;3317.137544238515;3319;3360.1263671445354;46028;46783.532164678596;46876.7656161717;47581;47743.76128119372;9236.769080773034;9299.953500232456;9379.812403751886;9381.90618093824;9401.200897923616;17122.40071597513;17178.74231886523;17201.655966880593;17228;17306.961582305103;6544.247411547638;6727.091842601186;6743.797686069426;6791.3548212919695;6807.4894382921475;3707.258548290353;3712.443133529938;3726.1057346236707;3748.0629842539365;3820.025893397166;2905.622269105003;2995.191298349477;3008.247938015496;3016.125323656115;3023.365093330425;499.6677209655538;500.95741861941417;506.3695698854949;517.2370753139089;518.6421369255202;625.1373105114913;634.1344065350763;641.2305233719555;650.5966300893476;658.1214079204316;7287.963560182271;7543.73596924105;7676.769696909102;7709.2290770922455;7822.217778222246;521.4003895520182;573.7590212110923;577.3648986115239;579.9507041901401;585.1077107411147;3609.5488063992;3640.7633503822167;3708.981455092707;3719.5722491913775;3735.402335626287;52798.73600632049;53046.204306935426;54333.45666543284;54971.175432368545;55014.724926375115;47275.76362118167;48201.276980845316;48509.75745121252;48657.5134248653;49121.263181052316;43252.56747432485;43326.78336608297;43639.34540981888;43809.12381752347;44322.33516497255;7123.287671233043;7187.281271872771;7202;7379.151397589131;7390.224026477143;28195.859020704764;28466.57300140458;29005.854970725013;29011;29198;36217;38187.61812381841;38592.807035965765;38740.80629596834;38901.22197555976;9642;9965.601375944882;9995.450250236307;10113.949430252802;10397.428141452292;10512.106470950055;10748.677539673823;10780.083692886192;10797.136229101496;10844.783104337712;10310.381377117097;10319.329243599443;10371.145841122901;10392.58429662805;10500.632477863239;9477.383970041925;9513.334066615547;9625.32622716431;9663.178629816544;9796.608135674493;9729.805403891742;9823.36148150368;9829.950850245703;9857.654982075594;9875.358101723365;8260.793480163044;8452.788680283042;8534.274586660204;8563.400561960603;8669.306455483673;8379.539125347921;8649.91350086491;8676.522791246289;8682.652693892174;8807.955960220157 02:42:04 INFO - PROCESS | 19909 | __end_tp_report 02:42:04 INFO - PROCESS | 19909 | __start_cc_report 02:42:04 INFO - PROCESS | 19909 | _x_x_mozilla_cycle_collect,368 02:42:04 INFO - PROCESS | 19909 | __end_cc_report 02:42:04 INFO - PROCESS | 19909 | __startTimestamp1460713324775__endTimestamp 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | ------- Summary: start ------- 02:42:04 INFO - PROCESS | 19909 | Number of tests: 6 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#0] dojo.html Cycles:165 Average:4762.38 Median:4910.26 stddev:496.87 (10.1%) stddev-sans-first:469.77 02:42:04 INFO - PROCESS | 19909 | Values: 2643.7 2700.5 2738.6 2745.8 2745.9 4800.4 4806.6 4817.2 4826.4 4894.2 4699.6 4813.6 4829.4 4881.8 4882.7 4402.6 4429.4 4475.4 4521.7 4568.0 4450.6 4471.4 4498.2 4512.2 4561.2 4334.7 4363.4 4452.1 4452.5 4483.2 4407.7 4409.2 4413.2 4422.8 4477.9 4383.4 4411.1 4414.5 4454.8 4467.4 4603.2 4668.6 4714.1 4738.9 4756.9 5097.4 5129.5 5129.5 5163.3 5189.3 5033.3 5184.3 5184.9 5189.1 5196.4 4764.6 4774.0 4813.3 4843.1 4861.6 5236.7 5251.8 5252.7 5263.7 5277.6 4910.3 5041.6 5069.5 5079.1 5085.8 5029.1 5114.5 5177.6 5202.5 5240.3 5079.3 5095.8 5100.6 5110.0 5155.6 5001.6 5082.4 5091.1 5096.8 5103.0 4247.7 4317.3 4317.6 4340.3 4373.1 3720.3 3764.5 3781.0 3781.4 3784.0 4380.6 4450.1 4451.6 4508.2 4538.2 5166.3 5208.1 5230.8 5231.9 5276.6 4480.4 4534.4 4541.4 4552.4 4583.1 4500.0 4584.6 4622.8 4672.1 4711.3 4860.0 4914.4 4919.6 4921.3 4957.9 5185.4 5233.3 5237.9 5243.9 5277.9 4784.7 4885.8 4909.6 4926.9 4973.2 5069.5 5077.3 5091.2 5095.0 5174.2 5149.4 5199.1 5199.8 5200.3 5213.4 4869.8 4872.0 4967.7 5008.2 5039.9 4949.7 4953.2 4961.6 4975.5 5005.2 4903.8 4924.4 4929.1 4945.4 4970.7 4946.2 5003.1 5004.7 5039.9 5068.8 4923.8 4941.3 4975.7 4987.8 5023.3 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#1] ext.html Cycles:180 Average:41731.45 Median:34363.83 stddev:69526.46 (202.3%) stddev-sans-first:69652.78 02:42:04 INFO - PROCESS | 19909 | Values: 561.1 568.8 595.3 602.7 602.8 26443.6 33728.7 34619.7 34697.0 34711.7 37758.0 38478.2 38637.6 38722.0 38736.6 7641.4 7846.6 7860.4 7875.2 7900.6 7692.8 7762.6 7778.6 7842.9 7966.2 7925.4 7995.6 8001.5 8012.0 8027.4 7933.7 7937.2 7941.7 7993.8 8002.8 7769.5 7918.0 7925.1 7928.3 7946.3 37924.4 38041.6 38192.0 38335.6 38409.8 2924.9 3033.8 3051.0 3105.5 3415.0 28903.4 29084.1 29087.6 29377.4 29707.0 3352.0 3384.3 3424.8 3474.7 3526.0 234781.0 237129.0 237539.0 237618.0 238617.0 29418.3 51750.0 52841.0 53082.0 53174.7 27837.0 27882.9 27961.4 28024.4 28167.9 13195.4 13278.8 13372.2 13437.9 13440.4 11286.0 11339.1 11371.0 11377.9 11398.1 8111.3 8122.9 8185.9 8195.1 8239.9 3189.6 3190.7 3251.8 3311.5 3323.8 986.4 1013.1 1048.1 1072.5 1080.7 28159.6 28193.3 28555.3 28583.9 28870.3 992.7 1042.4 1069.6 1105.7 1128.2 14129.9 14941.9 15120.1 15205.6 15380.2 293845.0 298522.0 306002.0 306732.0 307865.0 49349.3 50222.2 50278.5 50357.5 50363.7 1266.6 1288.5 1321.1 1331.6 1334.7 26521.7 27636.7 28047.3 28170.9 28181.9 42382.0 43082.1 43117.6 43213.6 43304.6 251528.0 251560.0 254640.0 254707.0 254929.0 37286.8 37508.8 38313.8 38662.2 38691.8 41717.0 41762.8 42627.4 42730.4 43063.6 35945.3 36081.6 36383.5 36405.6 36561.0 35200.5 35518.3 36314.8 36531.3 37718.6 32851.7 33089.5 33768.0 36950.9 38081.6 28944.3 32569.2 33625.2 34286.8 34440.8 23102.5 23168.2 23182.2 23342.2 23364.0 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#2] jquery.html Cycles:180 Average:22387.87 Median:5117.68 stddev:57712.53 (1127.7%) stddev-sans-first:57850.73 02:42:04 INFO - PROCESS | 19909 | Values: 361.4 362.6 372.8 385.0 389.6 15645.0 15840.7 16762.5 16838.2 16859.2 15461.5 15643.2 16113.9 16325.9 16328.6 5145.7 5304.4 5328.4 5332.3 5356.0 3649.0 5182.9 5722.6 6082.4 6092.9 6004.1 6017.4 6018.8 6019.5 6030.7 5015.4 5314.7 5344.9 5363.7 5371.9 5089.7 5193.5 5321.3 5500.5 5510.8 12103.6 12422.7 12468.4 12481.1 12506.4 1684.3 1751.6 1885.2 1919.8 1993.2 8979.7 9020.9 9238.3 9370.0 9453.4 1776.0 1853.0 1863.4 1867.3 1887.9 69292.7 71817.0 73271.3 74057.3 74669.0 9766.3 9777.6 10061.4 10073.4 10107.7 13809.7 13840.4 13864.1 13877.0 13898.8 6861.5 6902.5 6975.4 7041.4 7074.6 6465.4 6535.8 6553.7 6651.1 6667.9 4114.4 4172.3 4192.3 4219.1 4235.9 1627.0 1751.0 1760.1 1838.6 1898.0 833.5 870.6 880.4 897.9 909.3 15668.4 15873.5 16509.6 16722.0 16892.3 903.2 910.5 914.1 956.8 978.2 9117.8 9244.7 9440.5 9466.5 9548.6 288391.0 296477.0 376830.0 377303.0 384572.0 67228.3 71308.6 83622.0 83929.0 84908.0 964.8 967.9 979.8 983.9 995.7 15276.0 15277.4 15534.2 15713.8 15865.9 30975.8 31156.0 31734.0 32839.3 35443.6 38190.0 39719.2 39771.8 39914.2 40122.6 7706.4 7731.9 7821.5 7865.4 7950.3 6442.6 9931.3 10489.6 11079.2 11094.8 9550.6 9792.6 9892.9 9894.5 10121.3 10219.6 10223.1 10375.0 10416.4 10616.9 9997.5 10689.7 10762.3 10800.1 10965.8 6675.6 7017.0 7882.2 7892.8 7926.6 9408.4 9868.3 9888.8 10000.6 10040.4 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#3] mootools.html Cycles:180 Average:5152.05 Median:5366.54 stddev:2862.00 (53.3%) stddev-sans-first:2856.57 02:42:04 INFO - PROCESS | 19909 | Values: 1458.2 1486.5 1650.2 1785.6 1805.5 6944.9 7488.2 7630.4 7848.4 7874.7 7488.9 7513.4 7516.6 7530.0 7574.3 2138.4 2167.8 2169.1 2169.7 2171.9 2156.6 2158.2 2188.6 2191.0 2192.4 2148.7 2179.1 2192.2 2194.2 2208.4 2105.8 2123.2 2126.8 2130.6 2134.9 2090.9 2115.4 2119.4 2121.4 2139.3 7556.1 7616.7 7656.4 7680.5 7683.2 4446.3 4559.1 4566.4 4571.7 4575.4 2920.8 2929.9 2960.9 3022.1 3027.0 942.9 968.8 983.6 988.2 989.3 10151.7 10181.5 10182.5 10188.9 10208.2 4072.7 4122.2 4265.5 4285.1 4287.5 8746.3 8776.3 8802.7 8837.8 8846.6 4500.8 4534.1 4541.9 4552.2 4576.4 3810.0 4061.0 4104.3 4182.7 4286.9 3685.0 3707.0 3772.7 3787.0 3818.1 1201.2 1239.3 1249.8 1260.1 1275.5 804.2 895.9 908.1 913.8 915.7 5570.0 5606.7 5623.6 5695.7 5756.2 439.4 440.7 444.3 445.6 451.6 3649.2 3665.9 3671.3 3716.4 3746.4 9387.8 9916.7 9958.3 9983.4 9984.8 9568.4 9766.1 9845.0 9861.8 9874.0 7368.2 7376.1 7433.6 7523.1 7529.1 5300.5 5432.6 5512.5 5535.2 5577.6 8892.2 9121.0 9148.5 9183.4 9187.4 8848.6 9216.4 9263.0 9362.4 9376.2 6167.5 6500.8 6647.5 6732.3 6765.4 7245.4 7284.1 7304.6 7348.4 7388.9 6449.5 6548.9 6670.4 6708.8 6738.8 6456.6 6498.7 6662.3 6749.3 6760.4 6572.7 6642.5 6657.2 6664.9 6667.3 4708.8 4746.1 4835.0 4909.8 4910.1 4796.8 4903.1 4920.4 4940.1 4994.2 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#4] prototype.html Cycles:180 Average:4704.26 Median:5357.82 stddev:1372.26 (25.6%) stddev-sans-first:1336.04 02:42:04 INFO - PROCESS | 19909 | Values: 318.6 320.6 322.1 327.3 328.2 5341.9 5412.5 5457.5 5458.7 5466.2 5349.6 5351.3 5352.1 5363.5 5383.5 3932.8 4047.7 4149.5 4177.5 4199.4 4187.9 4194.8 4203.0 4206.7 4208.6 4150.2 4166.0 4166.9 4175.6 4181.6 4065.3 4166.4 4170.8 4172.7 4178.4 3651.1 3656.8 3678.6 3690.8 3704.7 5124.5 5140.9 5168.4 5185.6 5196.6 4754.2 4792.0 4802.2 4839.9 4870.8 5638.2 5645.2 5647.6 5667.7 5684.1 3985.8 3990.6 4023.6 4049.2 4065.7 5684.8 5910.1 5913.9 5976.7 6003.9 4123.3 4129.7 4130.3 4152.4 4165.9 4195.7 4195.8 4201.6 4211.4 4219.6 4642.7 4783.9 4789.1 4792.9 4799.4 5642.4 5645.7 5646.2 5653.9 5662.9 1456.4 1471.6 1473.5 1484.4 1486.9 942.1 963.5 991.8 997.6 1011.6 4941.3 4960.8 4980.8 4987.6 4997.5 5781.8 5806.7 5839.6 5848.7 5870.4 4861.6 4994.0 5007.7 5027.9 5035.7 3145.9 3154.1 3156.8 3166.8 3172.4 5510.9 5514.3 5517.4 5518.7 5537.7 5798.0 5986.3 6002.6 6004.8 6016.3 5471.7 5478.4 5480.5 5494.2 5496.9 5700.7 5799.7 5825.8 5829.7 5954.3 5778.0 5780.0 5810.8 5830.2 5851.6 5491.4 5500.8 5551.9 5559.7 5605.3 3828.4 4009.5 4024.8 4048.7 4077.6 5820.6 5859.3 5871.6 5882.7 5907.6 5555.9 5671.8 5674.6 5684.0 5699.6 5556.1 5663.2 5675.9 5701.2 5717.4 5349.0 5560.4 5576.5 5584.3 5593.8 5616.2 5772.3 5791.9 5792.2 5795.7 5590.0 5620.4 5625.1 5625.7 5642.1 02:42:04 INFO - PROCESS | 19909 | 02:42:04 INFO - PROCESS | 19909 | [#5] yui.html Cycles:180 Average:12626.39 Median:26660.07 stddev:14820.21 (55.6%) stddev-sans-first:14834.67 02:42:04 INFO - PROCESS | 19909 | Values: 687.8 700.9 728.5 779.7 789.8 11388.9 11725.8 11886.4 11934.0 12391.0 12636.2 12804.6 12819.3 12832.4 12837.0 641.8 815.3 819.6 821.7 827.0 794.8 797.6 803.8 804.6 809.0 837.0 838.2 838.4 841.0 843.9 833.1 835.0 836.4 838.5 852.2 617.3 622.3 623.6 627.4 630.6 11416.4 11455.0 11462.5 11504.2 11511.1 12316.1 12485.2 12486.9 12532.6 12814.9 9873.5 9959.9 10044.7 10100.5 10106.8 3268.1 3313.2 3317.1 3319.0 3360.1 46028.0 46783.5 46876.8 47581.0 47743.8 9236.8 9300.0 9379.8 9381.9 9401.2 17122.4 17178.7 17201.7 17228.0 17307.0 6544.2 6727.1 6743.8 6791.4 6807.5 3707.3 3712.4 3726.1 3748.1 3820.0 2905.6 2995.2 3008.2 3016.1 3023.4 499.7 501.0 506.4 517.2 518.6 625.1 634.1 641.2 650.6 658.1 7288.0 7543.7 7676.8 7709.2 7822.2 521.4 573.8 577.4 580.0 585.1 3609.5 3640.8 3709.0 3719.6 3735.4 52798.7 53046.2 54333.5 54971.2 55014.7 47275.8 48201.3 48509.8 48657.5 49121.3 43252.6 43326.8 43639.3 43809.1 44322.3 7123.3 7187.3 7202.0 7379.2 7390.2 28195.9 28466.6 29005.9 29011.0 29198.0 36217.0 38187.6 38592.8 38740.8 38901.2 9642.0 9965.6 9995.5 10113.9 10397.4 10512.1 10748.7 10780.1 10797.1 10844.8 10310.4 10319.3 10371.1 10392.6 10500.6 9477.4 9513.3 9625.3 9663.2 9796.6 9729.8 9823.4 9830.0 9857.7 9875.4 8260.8 8452.8 8534.3 8563.4 8669.3 8379.5 8649.9 8676.5 8682.7 8808.0 02:42:04 INFO - PROCESS | 19909 | -------- Summary: end -------- 02:42:04 INFO - PROCESS | 19909 | 02:42:05 INFO - TEST-INFO | 19909: exit 0 02:42:05 INFO - TEST-OK | dromaeo_css | took 1116419ms 02:42:05 INFO - TEST-START | kraken 02:42:05 INFO - operating with platform_type : linux_ 02:42:05 INFO - Initialising browser for kraken test... 02:42:05 INFO - TEST-INFO | started process 20154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQxunm/profile http://localhost:47359/getInfo.html) 02:42:09 INFO - PROCESS | 20154 | 02:42:09 INFO - PROCESS | 20154 | (process:20221): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:09 INFO - PROCESS | 20154 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 02:42:10 INFO - PROCESS | 20154 | __metrics Screen width/height:1600/1200 02:42:10 INFO - PROCESS | 20154 | colorDepth:24 02:42:10 INFO - PROCESS | 20154 | Browser inner width/height: 1024/697 02:42:10 INFO - PROCESS | 20154 | __metrics 02:42:11 ERROR - PROCESS | 20154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:42:12 INFO - TEST-INFO | 20154: exit 0 02:42:12 INFO - Browser initialized. 02:42:12 INFO - Running cycle 1/1 for kraken test... 02:42:12 INFO - TEST-INFO | started process 20272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQxunm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:14 INFO - PROCESS | 20272 | 02:42:14 INFO - PROCESS | 20272 | (process:20330): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:24 INFO - PROCESS | 20272 | RSS: Main: 164413440 02:42:24 INFO - PROCESS | 20272 | 02:42:26 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47359/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:27 INFO - PROCESS | 20272 | RSS: Main: 168710144 02:42:27 INFO - PROCESS | 20272 | 02:42:30 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47359/tests/kraken/driver.html?testName=audio-dft) 02:42:31 INFO - PROCESS | 20272 | RSS: Main: 171986944 02:42:31 INFO - PROCESS | 20272 | 02:42:34 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47359/tests/kraken/driver.html?testName=audio-fft) 02:42:34 INFO - PROCESS | 20272 | RSS: Main: 163454976 02:42:34 INFO - PROCESS | 20272 | 02:42:36 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47359/tests/kraken/driver.html?testName=audio-oscillator) 02:42:37 INFO - PROCESS | 20272 | RSS: Main: 163991552 02:42:37 INFO - PROCESS | 20272 | 02:42:39 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:42:40 INFO - PROCESS | 20272 | RSS: Main: 164249600 02:42:40 INFO - PROCESS | 20272 | 02:42:43 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47359/tests/kraken/driver.html?testName=imaging-darkroom) 02:42:44 INFO - PROCESS | 20272 | RSS: Main: 164483072 02:42:44 INFO - PROCESS | 20272 | 02:42:47 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47359/tests/kraken/driver.html?testName=imaging-desaturate) 02:42:48 INFO - PROCESS | 20272 | RSS: Main: 164306944 02:42:48 INFO - PROCESS | 20272 | 02:42:51 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47359/tests/kraken/driver.html?testName=json-parse-financial) 02:42:51 INFO - PROCESS | 20272 | RSS: Main: 164364288 02:42:51 INFO - PROCESS | 20272 | 02:42:53 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:42:54 INFO - PROCESS | 20272 | RSS: Main: 164413440 02:42:54 INFO - PROCESS | 20272 | 02:42:55 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:42:56 INFO - PROCESS | 20272 | RSS: Main: 164626432 02:42:56 INFO - PROCESS | 20272 | 02:42:58 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:42:59 INFO - PROCESS | 20272 | RSS: Main: 164958208 02:42:59 INFO - PROCESS | 20272 | 02:43:02 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:03 INFO - PROCESS | 20272 | RSS: Main: 164962304 02:43:03 INFO - PROCESS | 20272 | 02:43:06 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:06 INFO - PROCESS | 20272 | RSS: Main: 164904960 02:43:06 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | Cycle 1(1): loaded http://localhost:47359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47359/tests/kraken/driver.html?testName=ai-astar) 02:43:08 INFO - PROCESS | 20272 | RSS: Main: 166326272 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | __start_tp_report 02:43:08 INFO - PROCESS | 20272 | _x_x_mozilla_page_load 02:43:08 INFO - PROCESS | 20272 | _x_x_mozilla_page_load_details 02:43:08 INFO - PROCESS | 20272 | |i|pagename|runs| 02:43:08 INFO - PROCESS | 20272 | |0;ai-astar;114;106;112;112;113;125;114;113;113;114 02:43:08 INFO - PROCESS | 20272 | |1;audio-beat-detection;167;131;162;194;136;162;157;132;190;137 02:43:08 INFO - PROCESS | 20272 | |2;audio-dft;163;163;165;180;163;165;163;163;166;163 02:43:08 INFO - PROCESS | 20272 | |3;audio-fft;75;76;75;153;75;75;75;74;158;78 02:43:08 INFO - PROCESS | 20272 | |4;audio-oscillator;94;95;143;93;94;95;137;96;95;148 02:43:08 INFO - PROCESS | 20272 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;118;118;117 02:43:08 INFO - PROCESS | 20272 | |6;imaging-darkroom;148;148;147;148;148;148;147;147;149;148 02:43:08 INFO - PROCESS | 20272 | |7;imaging-desaturate;96;96;96;95;95;95;95;96;96;96 02:43:08 INFO - PROCESS | 20272 | |8;json-parse-financial;68;69;68;67;69;67;70;89;66;66 02:43:08 INFO - PROCESS | 20272 | |9;json-stringify-tinderbox;65;65;64;65;66;65;65;67;66;64 02:43:08 INFO - PROCESS | 20272 | |10;stanford-crypto-aes;86;92;85;86;87;86;87;86;89;92 02:43:08 INFO - PROCESS | 20272 | |11;stanford-crypto-ccm;148;141;138;145;146;149;138;142;178;143 02:43:08 INFO - PROCESS | 20272 | |12;stanford-crypto-pbkdf2;175;182;181;177;185;175;180;175;177;175 02:43:08 INFO - PROCESS | 20272 | |13;stanford-crypto-sha256-iterative;74;72;74;75;71;72;73;73;74;72 02:43:08 INFO - PROCESS | 20272 | __end_tp_report 02:43:08 INFO - PROCESS | 20272 | __start_cc_report 02:43:08 INFO - PROCESS | 20272 | _x_x_mozilla_cycle_collect,894 02:43:08 INFO - PROCESS | 20272 | __end_cc_report 02:43:08 INFO - PROCESS | 20272 | __startTimestamp1460713388704__endTimestamp 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | ------- Summary: start ------- 02:43:08 INFO - PROCESS | 20272 | Number of tests: 14 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.50 stddev:4.65 (4.1%) stddev-sans-first:4.93 02:43:08 INFO - PROCESS | 20272 | Values: 114.0 106.0 112.0 112.0 113.0 125.0 114.0 113.0 113.0 114.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:162.00 stddev:22.97 (14.2%) stddev-sans-first:24.07 02:43:08 INFO - PROCESS | 20272 | Values: 167.0 131.0 162.0 194.0 136.0 162.0 157.0 132.0 190.0 137.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#2] audio-dft Cycles:10 Average:165.40 Median:164.00 stddev:5.25 (3.2%) stddev-sans-first:5.50 02:43:08 INFO - PROCESS | 20272 | Values: 163.0 163.0 165.0 180.0 163.0 165.0 163.0 163.0 166.0 163.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#3] audio-fft Cycles:10 Average:91.40 Median:75.00 stddev:33.82 (45.1%) stddev-sans-first:35.35 02:43:08 INFO - PROCESS | 20272 | Values: 75.0 76.0 75.0 153.0 75.0 75.0 75.0 74.0 158.0 78.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:94.50 stddev:23.39 (24.8%) stddev-sans-first:24.17 02:43:08 INFO - PROCESS | 20272 | Values: 94.0 95.0 143.0 93.0 94.0 95.0 137.0 96.0 95.0 148.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:43:08 INFO - PROCESS | 20272 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 02:43:08 INFO - PROCESS | 20272 | Values: 148.0 148.0 147.0 148.0 148.0 148.0 147.0 147.0 149.0 148.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:43:08 INFO - PROCESS | 20272 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#8] json-parse-financial Cycles:10 Average:69.90 Median:68.50 stddev:6.84 (10.0%) stddev-sans-first:7.22 02:43:08 INFO - PROCESS | 20272 | Values: 68.0 69.0 68.0 67.0 69.0 67.0 70.0 89.0 66.0 66.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 02:43:08 INFO - PROCESS | 20272 | Values: 65.0 65.0 64.0 65.0 66.0 65.0 65.0 67.0 66.0 64.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:2.55 (2.9%) stddev-sans-first:2.64 02:43:08 INFO - PROCESS | 20272 | Values: 86.0 92.0 85.0 86.0 87.0 86.0 87.0 86.0 89.0 92.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:145.50 stddev:11.59 (8.0%) stddev-sans-first:12.29 02:43:08 INFO - PROCESS | 20272 | Values: 148.0 141.0 138.0 145.0 146.0 149.0 138.0 142.0 178.0 143.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:178.50 stddev:3.58 (2.0%) stddev-sans-first:3.61 02:43:08 INFO - PROCESS | 20272 | Values: 175.0 182.0 181.0 177.0 185.0 175.0 180.0 175.0 177.0 175.0 02:43:08 INFO - PROCESS | 20272 | 02:43:08 INFO - PROCESS | 20272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.50 stddev:1.25 (1.7%) stddev-sans-first:1.27 02:43:08 INFO - PROCESS | 20272 | Values: 74.0 72.0 74.0 75.0 71.0 72.0 73.0 73.0 74.0 72.0 02:43:08 INFO - PROCESS | 20272 | -------- Summary: end -------- 02:43:08 INFO - PROCESS | 20272 | 02:43:09 INFO - TEST-INFO | 20272: exit 0 02:43:09 INFO - TEST-OK | kraken | took 64159ms 02:43:09 INFO - SUITE-END | took 1180s 02:43:09 INFO - Completed test suite (00:19:40) 02:43:09 INFO - javascript benchmark 02:43:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.695974962879, 2700.4734076855007, 2738.6302849115364, 2745.807793454459, 2745.8901643934246, 4800.375951126353, 4806.591439727623, 4817.205161148415, 4826.444958829736, 4894.167991441454, 4699.647526435514, 4813.6389770767155, 4829.396325459317, 4881.804727810883, 4882.658213925027, 4402.603765661098, 4429.402030725859, 4475.418195634563, 4521.660875434355, 4568.0, 4450.599446049855, 4471.39636149119, 4498.212812757771, 4512.187806194884, 4561.201789686808, 4334.653227741789, 4363.367311739812, 4452.109578084363, 4452.48796388413, 4483.170613436492, 4407.735535867858, 4409.206342858284, 4413.183561041185, 4422.778861056967, 4477.932831007537, 4383.430154079981, 4411.09572537629, 4414.4923333816705, 4454.754988475633, 4467.441569803775, 4603.194440972817, 4668.649851261169, 4714.080754252922, 4738.881527961794, 4756.9286460703115, 5097.439281679012, 5129.461406552296, 5129.461406552333, 5163.302954101186, 5189.325387699612, 5033.270175824521, 5184.27420161174, 5184.870378240536, 5189.117849965515, 5196.350456192976, 4764.571188593043, 4774.045190961821, 4813.253945638432, 4843.055604157226, 4861.611071114302, 5236.711980841091, 5251.8161864335325, 5252.737363131904, 5263.6841789492755, 5277.551408130275, 4910.263460480885, 5041.596672266283, 5069.543741063322, 5079.136546786981, 5085.821996230188, 5029.094762942632, 5114.488551144856, 5177.637565370388, 5202.505761952609, 5240.318758561362, 5079.288899554065, 5095.821646242363, 5100.617453690914, 5110.0, 5155.639105262596, 5001.624878134082, 5082.390113186368, 5091.0836049511445, 5096.770645320969, 5103.0, 4247.68142389322, 4317.309230523164, 4317.611414972667, 4340.327249276367, 4373.103513779667, 3720.3489389356755, 3764.5294338207723, 3780.9980355205894, 3781.3760729479327, 3784.0, 4380.561943805657, 4450.109978004347, 4451.621612162938, 4508.211063064016, 4538.160440318552, 5166.302549155891, 5208.088584497697, 5230.843074707765, 5231.921521177185, 5276.577873770089, 4480.439945006874, 4534.410526631516, 4541.409616749801, 4552.430946131733, 4583.083383323348, 4500.032493014018, 4584.633229341644, 4622.791974361162, 4672.065586882569, 4711.316859055418, 4859.975700121477, 4914.361133052752, 4919.606431485401, 4921.335619691439, 4957.851264462072, 5185.351831021122, 5233.267342572119, 5237.869053273698, 5243.947560524346, 5277.920831187458, 4784.6889952153, 4885.755712214304, 4909.582685471775, 4926.8768280793265, 4973.154563724248, 5069.467705890976, 5077.263796749525, 5091.236314552847, 5094.981003799181, 5174.172132458789, 5149.407818100966, 5199.090159222045, 5199.792008319625, 5200.349956255468, 5213.374395072616, 4869.805207791649, 4871.975640121776, 4967.726775027409, 5008.248762685626, 5039.949600503948, 4949.653524253267, 4953.23224900141, 4961.603071754179, 4975.477574854588, 5005.24921261799, 4903.828366007173, 4924.359833221658, 4929.137400954747, 4945.357103576512, 4970.676906001098, 4946.183879659816, 5003.124453220599, 5004.724740139181, 5039.874003149951, 5068.847934561969, 4923.8276660316715, 4941.308216849716, 4975.676581022367, 4987.825426110068, 5023.271625614192], "value": 4730.889096895316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1441211535055, 568.8293511946416, 595.2797115490255, 602.7378090530617, 602.7588964414231, 26443.603345949825, 33728.66271337286, 34619.65380346196, 34697.0, 34711.65288347116, 37758.0, 38478.23043539128, 38637.613623863755, 38722.03194920121, 38736.61263387365, 7641.4335061312295, 7846.6469008894455, 7860.37117030639, 7875.173106823787, 7900.565468899208, 7692.769216923473, 7762.573058481781, 7778.64996075178, 7842.921570784276, 7966.243206895365, 7925.405594580401, 7995.640196191156, 8001.479903806234, 8012.0, 8027.397945154137, 7933.682652693886, 7937.206279372074, 7941.722039728611, 7993.760187194393, 8002.799930001738, 7769.53382797034, 7918.049834019955, 7925.088614809255, 7928.286454219148, 7946.2848343648775, 37924.43113353302, 38041.61958380409, 38192.0, 38335.616643833484, 38409.80795096035, 2924.8683809228637, 3033.8028028178096, 3050.9847450762827, 3105.534169874537, 3414.9658503415144, 28903.42193156146, 29084.12747617575, 29087.56368654472, 29377.412451751057, 29707.0, 3351.9664803352143, 3384.3062172254627, 3424.7945123292684, 3474.687278144954, 3525.982370088159, 234781.0, 237129.0, 237539.0, 237618.0, 238616.99999999825, 29418.264543386158, 51750.0, 52841.0, 53082.0, 53174.734126329124, 27837.0, 27882.860585697348, 27961.44077118446, 28024.43951120966, 28167.859160704476, 13195.406206720721, 13278.800817987738, 13372.197668139943, 13437.865621343857, 13440.395182216627, 11286.0, 11339.092872570174, 11371.0, 11377.886221137682, 11398.088152947745, 8111.269985701315, 8122.9187708123345, 8185.877211841827, 8195.139510351328, 8239.917600824036, 3189.6012998375204, 3190.734578449327, 3251.8374081296315, 3311.536384906115, 3323.7673362864366, 986.3933680786408, 1013.1388319928002, 1048.1352883870836, 1072.51736718477, 1080.713610893114, 28159.577606335923, 28193.295167620974, 28555.286117846805, 28583.85708071488, 28870.278243044093, 992.7418871093423, 1042.4370839746452, 1069.614938622111, 1105.745678493951, 1128.2440764687678, 14129.929350353183, 14941.925290373478, 15120.092794432368, 15205.61985950338, 15380.154091525073, 293845.0, 298522.0, 306002.0, 306732.0, 307865.0, 49349.25976110361, 50222.24666630004, 50278.49721502738, 50357.49642503601, 50363.74818125886, 1266.5877546535546, 1288.5425673885823, 1321.0554453565555, 1331.5672406467936, 1334.7130366971148, 26521.734782651925, 27636.72363276422, 28047.29881752891, 28170.85914570414, 28181.859090704416, 42382.0, 43082.13835723331, 43117.568824311355, 43213.567864320954, 43304.56695433131, 251528.0, 251560.0, 254640.0, 254707.0, 254929.0, 37286.813565931996, 37508.81245593754, 38313.808430957666, 38662.22675546529, 38691.80654096712, 41717.0, 41762.791186043876, 42627.3605895918, 42730.359044614976, 43063.56936430596, 35945.281094378486, 36081.63918360888, 36383.45424818577, 36405.63594364023, 36561.0, 35200.47199292064, 35518.28963420665, 36314.8184259077, 36531.269374611824, 37718.62281377261, 32851.67148328582, 33089.50365744468, 33768.0, 36950.89147325585, 38081.619183808914, 28944.276393090342, 32569.18577035593, 33625.15937101592, 34286.828565858006, 34440.82779586086, 23102.537949240585, 23168.18911338095, 23182.1886233981, 23342.183023594094, 23364.0], "value": 16413.77542187864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.400075874049, 362.5920839056062, 372.79496277047633, 384.9576546579874, 389.5695256741301, 15645.0, 15840.683186336266, 16762.497125086236, 16838.15809209538, 16859.15704214789, 15461.458848940289, 15643.217839108056, 16113.91943040286, 16325.91837040816, 16328.591785205375, 5145.691258524501, 5304.416514183436, 5328.387235467912, 5332.280142180794, 5355.973220133894, 3649.0, 5182.922256166161, 5722.570807189457, 6082.391760823926, 6092.878142437148, 6004.099385092228, 6017.368176341487, 6018.8194354169445, 6019.458248757611, 6030.668313242792, 5015.3730783652045, 5314.681119132864, 5344.893102137936, 5363.731813409353, 5371.946280537184, 5089.669171503878, 5193.480651934814, 5321.308229930123, 5500.477454641843, 5510.8071217507595, 12103.636890893287, 12422.689432764162, 12468.376581170996, 12481.126321157522, 12506.374681265901, 1684.309433132422, 1751.5971326594827, 1885.161103309028, 1919.7888232294436, 1993.2326054468988, 8979.68571100015, 9020.909790902073, 9238.260939124853, 9370.0, 9453.43279403238, 1775.9911200443914, 1852.9536761581069, 1863.4130248971667, 1867.2530987605066, 1887.9339223127124, 69292.6535367325, 71817.0, 73271.26728732698, 74057.25942740611, 74669.0, 9766.267529935283, 9777.560009799576, 10061.446620435947, 10073.445960472245, 10107.7473063174, 13809.654758631115, 13840.377183026789, 13864.098833575785, 13877.028607997545, 13898.791518127236, 6861.519693621499, 6902.516823822385, 6975.441964642816, 7041.436685065182, 7074.610896400747, 6465.418112369909, 6535.790878687458, 6553.705083271264, 6651.102101216371, 6667.86664266712, 4114.403411505315, 4172.311568591209, 4192.329227323675, 4219.1139860629, 4235.882058970515, 1626.991865040667, 1750.9737353939702, 1760.119940029985, 1838.5955089880206, 1898.032003678134, 833.4999000599591, 870.6473878079388, 880.4057261348693, 897.9102089791099, 909.340727972228, 15668.373265069498, 15873.52379428619, 16509.58726031859, 16722.0, 16892.324307027582, 903.1645727701981, 910.499225426013, 914.1087439746194, 956.8421210500189, 978.2467500024941, 9117.77205569866, 9244.722658320261, 9440.527973601293, 9466.479343636029, 9548.570314335871, 288391.0, 296477.0, 376830.0, 377303.0, 384572.0, 67228.32771672221, 71308.64345678239, 83622.0, 83929.0, 84908.0, 964.840801267797, 967.8935317115112, 979.7991411760572, 983.9360441571275, 995.716220877061, 15276.0, 15277.388904443698, 15534.22328883574, 15713.764293535834, 15865.920670396574, 30975.84512077425, 31156.0, 31734.0, 32839.34321313513, 35443.582256709444, 38190.045248869, 39719.205615886945, 39771.80114099411, 39914.2017159661, 40122.59877401189, 7706.422018348534, 7731.884021739791, 7821.530708157301, 7865.370770338473, 7950.284474397101, 6442.645654488861, 9931.304808663324, 10489.580416783243, 11079.224454288445, 11094.833577496183, 9550.617975280911, 9792.608295668379, 9892.851607225753, 9894.455804930798, 10121.336196135158, 10219.59121635156, 10223.064934033664, 10375.011241344273, 10416.375017498975, 10616.89383106159, 9997.500124993867, 10689.679309620724, 10762.300450470695, 10800.135989121009, 10965.780684386427, 6675.632840193836, 7016.982537532132, 7882.211778822072, 7892.84214315722, 7926.603669816602, 9408.435493870116, 9868.259880508847, 9888.752781180528, 10000.649977250761, 10040.397576145455], "value": 7945.47764605052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.2052781234227, 1486.5168820133456, 1650.2326418215528, 1785.5982403959104, 1805.524365596227, 6944.861102777942, 7488.176300606929, 7630.351420129289, 7848.411369147316, 7874.724384646539, 7488.85022299555, 7513.361364284029, 7516.5865877376855, 7529.962350188255, 7574.280443357886, 2138.433315171477, 2167.8265738740943, 2169.110664627503, 2169.7287839020123, 2171.913123475059, 2156.590247852903, 2158.1583182558816, 2188.5951099046647, 2190.9780902190932, 2192.440927563469, 2148.731408573928, 2179.073893595216, 2192.1888901106613, 2194.2320187934256, 2208.4147700859285, 2105.842061845368, 2123.150739704115, 2126.797954194349, 2130.648443006902, 2134.861234019799, 2090.937271881846, 2115.3653903828945, 2119.4171602809197, 2121.352987338861, 2139.2726472999097, 7556.093268807724, 7616.733414330527, 7656.425768067362, 7680.5391676499585, 7683.231676832328, 4446.3108218226225, 4559.088182363507, 4566.429196350457, 4571.725696458223, 4575.359449677047, 2920.810147340437, 2929.8828046878098, 2960.9111726648234, 3022.063160420255, 3026.9848650756826, 942.9057094290516, 968.8498282766183, 983.6016413352604, 988.2390559269322, 989.3124278626358, 10151.746206344827, 10181.541830617565, 10182.490875456271, 10188.898111018869, 10208.234382421348, 4072.714909956275, 4122.175564886975, 4265.53079161292, 4285.142971405731, 4287.528371879091, 8746.256568191648, 8776.297896168291, 8802.735917922473, 8837.823243535222, 8846.557672116369, 4500.752458614807, 4534.13851368239, 4541.909161816745, 4552.180607490617, 4576.359309696645, 3809.961900381016, 4060.959390406117, 4104.322786740214, 4182.728122672017, 4286.906838756097, 3685.0, 3707.0, 3772.6981841452616, 3787.0, 3818.1218319786603, 1201.237214368882, 1239.3307613888398, 1249.8375211222483, 1260.0990291941307, 1275.4515558310015, 804.2038382001776, 895.8745775591423, 908.0964440381862, 913.7989642278689, 915.7023967210683, 5570.0, 5606.747696353674, 5623.550115990711, 5695.686737229492, 5756.194132821408, 439.40680081889195, 440.7113340761806, 444.27583039645174, 445.61899575862174, 451.58454222115734, 3649.197176621139, 3665.8533658653355, 3671.3391589514144, 3716.4053751399647, 3746.4193050077283, 9387.812243755086, 9916.702498925044, 9958.253131015203, 9983.400995940267, 9984.750381240381, 9568.425894446356, 9766.121049105615, 9845.0, 9861.802763944681, 9873.950630246947, 7368.226336234726, 7376.114866215981, 7433.553986760703, 7523.059617547807, 7529.134149572869, 5300.469953004823, 5432.619716619799, 5512.5314348280845, 5535.169724541351, 5577.637453565505, 8892.199702026848, 9121.042290559395, 9148.542572871196, 9183.357164998386, 9187.448753074837, 8848.557572121497, 9216.447013179231, 9263.0, 9362.391444556082, 9376.156145946898, 6167.475764560063, 6500.837479063061, 6647.5014373921185, 6732.293109223461, 6765.42493888025, 7245.420366370572, 7284.125904891447, 7304.598247096461, 7348.448866335153, 7388.889166662612, 6449.516286278454, 6548.901766473602, 6670.39966403026, 6708.798736037927, 6738.797836064926, 6456.580322279036, 6498.675066246763, 6662.267150613526, 6749.257581666111, 6760.391564759196, 6572.7042283098335, 6642.468602511691, 6657.167854018247, 6664.900026499703, 6667.266600674019, 4708.835190768306, 4746.098241334135, 4834.95165048345, 4909.754512274443, 4910.06708725341, 4796.808127674994, 4903.068417000758, 4920.40955085392, 4940.135476291563, 4994.225894986283], "value": 4111.998479219422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.59220198146375, 320.64408506557714, 322.13828010073064, 327.27835123552586, 328.23193726679597, 5341.866453338664, 5412.4587541245855, 5457.544105152678, 5458.6724796512135, 5466.1527463243265, 5349.5720342372615, 5351.331083614548, 5352.090144675405, 5363.544098751601, 5383.542398896098, 3932.8230229639594, 4047.655949244303, 4149.5228048774325, 4177.51958524769, 4199.433076534675, 4187.853425130121, 4194.832206711728, 4202.97898510507, 4206.747595144286, 4208.642265407429, 4150.211459822624, 4166.0, 4166.916541729135, 4175.582441755815, 4181.560936101711, 4065.349544072949, 4166.375043743433, 4170.812313445902, 4172.749635021908, 4178.352355384905, 3651.1054791575966, 3656.8354424050717, 3678.6321367863266, 3690.833912473918, 3704.74066815323, 5124.461931497176, 5140.91545072957, 5168.405633352138, 5185.585153187736, 5196.636235463519, 4754.215554433515, 4792.0, 4802.183628783116, 4839.854804355875, 4870.805167793284, 5638.238837756891, 5645.181448689917, 5647.632903861236, 5667.716614169316, 5684.118961560965, 3985.8405663773415, 3990.6009399060154, 4023.5775243599587, 4049.2104039712267, 4065.6544193743566, 5684.772609095631, 5910.08393698973, 5913.881722365529, 5976.671283079429, 6003.889280483081, 4123.340265557496, 4129.669626429878, 4130.277201489727, 4152.418661387408, 4165.875023749292, 4195.685323600742, 4195.811188496525, 4201.558836322203, 4211.410402543646, 4219.599138081878, 4642.651801114863, 4783.880402989884, 4789.137955168103, 4792.856214313576, 4799.424069111729, 5642.379338272786, 5645.71771411436, 5646.20953066571, 5653.943460565341, 5662.886742265214, 1456.3955958277409, 1471.6468047668482, 1473.5358362115899, 1484.3988184784964, 1486.9405223790927, 942.1050002497655, 963.494165563071, 991.7768502087117, 997.6258902911409, 1011.6004178349658, 4941.2835138905375, 4960.826371076995, 4980.7509624518625, 4987.5760560352055, 4997.500249975046, 5781.82654520365, 5806.68063256525, 5839.620424672383, 5848.736806843617, 5870.442307980735, 4861.5914372297975, 4993.950060499348, 5007.749612519359, 5027.899442011212, 5035.672681275705, 3145.8741650334186, 3154.1326135312515, 3156.779025468241, 3166.799074643101, 3172.3655268946304, 5510.889782204334, 5514.255575497336, 5517.393086760453, 5518.668879867221, 5537.723113844372, 5798.0, 5986.311574168939, 6002.6098303611, 6004.759809607567, 6016.338202797689, 5471.671699698031, 5478.424765399575, 5480.479354461399, 5494.230807686927, 5496.945030549723, 5700.714964251853, 5799.739011744566, 5825.79609713658, 5829.708514574169, 5954.315253745702, 5777.971110144423, 5779.971100144472, 5810.767569297181, 5830.154627578892, 5851.590388672922, 5491.395946445808, 5500.752466138953, 5551.861203469945, 5559.749811258423, 5605.299337582802, 3828.406596977473, 4009.4787677601726, 4024.7987600620436, 4048.716589838683, 4077.612626800449, 5820.563457740602, 5859.296884373903, 5871.647701137946, 5882.705864706833, 5907.556933230111, 5555.888582504187, 5671.801486948102, 5674.631148975303, 5684.0, 5699.6035971185665, 5556.138798486241, 5663.235463212413, 5675.914861277167, 5701.201831743476, 5717.399673034438, 5348.983693098299, 5560.387487628543, 5576.470235327637, 5584.274044374205, 5593.776248949996, 5616.241807355955, 5772.278465191851, 5791.9131213031, 5792.160136780059, 5795.652260864362, 5589.972050139723, 5620.4098569649595, 5625.09998400254, 5625.746841392229, 5642.097264437671], "value": 4267.464664528526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.8005378440253, 700.8983697363885, 728.4572993120123, 779.6842278877054, 789.7551758954725, 11388.886111138887, 11725.7654846903, 11886.405679716023, 11933.985611223046, 12391.0, 12636.178648387848, 12804.551840685577, 12819.294938778363, 12832.422540985655, 12837.037222208324, 641.7785863876978, 815.343648363069, 819.5656302159865, 821.7329367955408, 826.9751907442757, 794.7774623105539, 797.5812698333392, 803.8191406933452, 804.569555287921, 809.0210844877705, 836.9916300837006, 838.1618381618382, 838.4214891724721, 840.9747707568782, 843.9493630382196, 833.1418638801983, 834.9916500834975, 836.3685417509741, 838.4969018588829, 852.1776485691306, 617.305531277313, 622.2781573374864, 623.6414061914418, 627.3976982097192, 630.6247782569363, 11416.42917854104, 11455.026322762575, 11462.541498340057, 11504.194706370557, 11511.136664750093, 12316.076294277875, 12485.188462749893, 12486.937565312206, 12532.624021279376, 12814.935925320313, 9873.456959867204, 9959.90040099597, 10044.698659040241, 10100.545475453622, 10106.848397274047, 3268.1176082457605, 3313.1717070732316, 3317.137544238515, 3319.0, 3360.1263671445354, 46028.0, 46783.532164678596, 46876.7656161717, 47581.0, 47743.76128119372, 9236.769080773034, 9299.953500232456, 9379.812403751886, 9381.90618093824, 9401.200897923616, 17122.40071597513, 17178.74231886523, 17201.655966880593, 17228.0, 17306.961582305103, 6544.247411547638, 6727.091842601186, 6743.797686069426, 6791.3548212919695, 6807.4894382921475, 3707.258548290353, 3712.443133529938, 3726.1057346236707, 3748.0629842539365, 3820.025893397166, 2905.622269105003, 2995.191298349477, 3008.247938015496, 3016.125323656115, 3023.365093330425, 499.6677209655538, 500.95741861941417, 506.3695698854949, 517.2370753139089, 518.6421369255202, 625.1373105114913, 634.1344065350763, 641.2305233719555, 650.5966300893476, 658.1214079204316, 7287.963560182271, 7543.73596924105, 7676.769696909102, 7709.2290770922455, 7822.217778222246, 521.4003895520182, 573.7590212110923, 577.3648986115239, 579.9507041901401, 585.1077107411147, 3609.5488063992, 3640.7633503822167, 3708.981455092707, 3719.5722491913775, 3735.402335626287, 52798.73600632049, 53046.204306935426, 54333.45666543284, 54971.175432368545, 55014.724926375115, 47275.76362118167, 48201.276980845316, 48509.75745121252, 48657.5134248653, 49121.263181052316, 43252.56747432485, 43326.78336608297, 43639.34540981888, 43809.12381752347, 44322.33516497255, 7123.287671233043, 7187.281271872771, 7202.0, 7379.151397589131, 7390.224026477143, 28195.859020704764, 28466.57300140458, 29005.854970725013, 29011.0, 29198.0, 36217.0, 38187.61812381841, 38592.807035965765, 38740.80629596834, 38901.22197555976, 9642.0, 9965.601375944882, 9995.450250236307, 10113.949430252802, 10397.428141452292, 10512.106470950055, 10748.677539673823, 10780.083692886192, 10797.136229101496, 10844.783104337712, 10310.381377117097, 10319.329243599443, 10371.145841122901, 10392.58429662805, 10500.632477863239, 9477.383970041925, 9513.334066615547, 9625.32622716431, 9663.178629816544, 9796.608135674493, 9729.805403891742, 9823.36148150368, 9829.950850245703, 9857.654982075594, 9875.358101723365, 8260.793480163044, 8452.788680283042, 8534.274586660204, 8563.400561960603, 8669.306455483673, 8379.539125347921, 8649.91350086491, 8676.522791246289, 8682.652693892174, 8807.955960220157], "value": 5802.807220386944, "unit": "score"}], "name": "dromaeo_css", "value": 6305.153886355275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 106.0, 112.0, 112.0, 113.0, 125.0, 114.0, 113.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 162.0, 194.0, 136.0, 162.0, 157.0, 132.0, 190.0, 137.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 180.0, 163.0, 165.0, 163.0, 163.0, 166.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 153.0, 75.0, 75.0, 75.0, 74.0, 158.0, 78.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 143.0, 93.0, 94.0, 95.0, 137.0, 96.0, 95.0, 148.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 69.0, 67.0, 70.0, 89.0, 66.0, 66.0], "value": 69.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 85.0, 86.0, 87.0, 86.0, 87.0, 86.0, 89.0, 92.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 138.0, 145.0, 146.0, 149.0, 138.0, 142.0, 178.0, 143.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 182.0, 181.0, 177.0, 185.0, 175.0, 180.0, 175.0, 177.0, 175.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 75.0, 71.0, 72.0, 73.0, 73.0, 74.0, 72.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1617.6999999999998, "alertThreshold": 2.0}]} 02:43:09 INFO - Return code: 0 02:43:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:43:10 ERROR - # TBPL SUCCESS # 02:43:10 INFO - Running post-action listener: _resource_record_post_action 02:43:10 INFO - Running post-run listener: _resource_record_post_run 02:43:11 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 529911808; Read time: 0; Write time: 400308 02:43:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233975808; Read time: 0; Write time: 212116 02:43:11 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 295936000; Read time: 0; Write time: 188192 02:43:11 INFO - Running post-run listener: _upload_blobber_files 02:43:11 INFO - Blob upload gear active. 02:43:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:11 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 02:43:11 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'] 02:43:11 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 02:43:11 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:43:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:12 INFO - (blobuploader) - INFO - Done attempting. 02:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:13 INFO - (blobuploader) - INFO - Done attempting. 02:43:13 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:13 INFO - Return code: 0 02:43:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44a7099748b7c326e6d664293f0a8389585120c0b965a1353e6437b3c01af420e15e8ea1f7d83b27c851f0e85ccc3cf5b00af85a5af081216bc826afd73f6fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbe48bb46565b43514f6cd058f29f30c91626a8d7f915be097fc9ab4f3853a6ab9dfefc6f23ad12ccbde66eac10957d994498de1708020ee7dffe5158f0d185"} 02:43:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:13 INFO - Contents: 02:43:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44a7099748b7c326e6d664293f0a8389585120c0b965a1353e6437b3c01af420e15e8ea1f7d83b27c851f0e85ccc3cf5b00af85a5af081216bc826afd73f6fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbe48bb46565b43514f6cd058f29f30c91626a8d7f915be097fc9ab4f3853a6ab9dfefc6f23ad12ccbde66eac10957d994498de1708020ee7dffe5158f0d185"} 02:43:13 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:13 INFO - Copying logs to upload dir... 02:43:13 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.027431 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-15 02:43:13.513468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:13.516925) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 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/44a7099748b7c326e6d664293f0a8389585120c0b965a1353e6437b3c01af420e15e8ea1f7d83b27c851f0e85ccc3cf5b00af85a5af081216bc826afd73f6fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbe48bb46565b43514f6cd058f29f30c91626a8d7f915be097fc9ab4f3853a6ab9dfefc6f23ad12ccbde66eac10957d994498de1708020ee7dffe5158f0d185"} build_url:https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011464 build_url: 'https://queue.taskcluster.net/v1/task/bhE7J2UCR2mKo2kQ0AsKTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/44a7099748b7c326e6d664293f0a8389585120c0b965a1353e6437b3c01af420e15e8ea1f7d83b27c851f0e85ccc3cf5b00af85a5af081216bc826afd73f6fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcbe48bb46565b43514f6cd058f29f30c91626a8d7f915be097fc9ab4f3853a6ab9dfefc6f23ad12ccbde66eac10957d994498de1708020ee7dffe5158f0d185"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:13.542070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:13.542400) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1460711899.890128-1079437702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:43:13.625665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:43:13.626001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:43:13.626309) ========= ========= Total master_lag: 0.17 =========